builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1448635656.05 results: success (0) buildid: 20151127060814 builduid: abc686468f0747af9fa342c65131b86d revision: 958669938c10f37112896f1f47e8ed8074c1495d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.046472) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.046876) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.047184) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006549 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.075660) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.075953) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.092687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.092960) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004784 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.144581) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.145027) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.145397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.145696) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-27 06:47:36-- 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% 64.1M=0s 2015-11-27 06:47:36 (64.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.353825) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.354184) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019953 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.405576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.406075) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 958669938c10f37112896f1f47e8ed8074c1495d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 958669938c10f37112896f1f47e8ed8074c1495d --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=b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-27 06:47:36,809 truncating revision to first 12 chars 2015-11-27 06:47:36,809 Setting DEBUG logging. 2015-11-27 06:47:36,809 attempt 1/10 2015-11-27 06:47:36,809 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/958669938c10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-27 06:47:37,033 unpacking tar archive at: fx-team-958669938c10/testing/mozharness/ program finished with exit code 0 elapsedTime=0.476045 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.896613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.896982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.905382) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.905734) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 06:47:36.906208) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-11-27 06:47:36.906662) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:47:37 INFO - MultiFileLogger online at 20151127 06:47:37 in /builds/slave/test 06:47:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:47:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:47:37 INFO - {'append_to_log': False, 06:47:37 INFO - 'base_work_dir': '/builds/slave/test', 06:47:37 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:47:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:47:37 INFO - 'branch': 'Fx-Team-Non-PGO', 06:47:37 INFO - 'buildbot_json_path': 'buildprops.json', 06:47:37 INFO - 'config_files': ('talos/linux_config.py',), 06:47:37 INFO - 'default_actions': ('clobber', 06:47:37 INFO - 'read-buildbot-config', 06:47:37 INFO - 'download-and-extract', 06:47:37 INFO - 'populate-webroot', 06:47:37 INFO - 'create-virtualenv', 06:47:37 INFO - 'install', 06:47:37 INFO - 'run-tests'), 06:47:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:47:37 INFO - 'download_minidump_stackwalk': True, 06:47:37 INFO - 'download_symbols': 'ondemand', 06:47:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:47:37 INFO - 'tooltool.py': '/tools/tooltool.py', 06:47:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:47:37 INFO - '/tools/misc-python/virtualenv.py')}, 06:47:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:47:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:47:37 INFO - 'installer_path': 'installer.exe', 06:47:37 INFO - 'log_level': 'info', 06:47:37 INFO - 'log_name': 'talos', 06:47:37 INFO - 'log_to_console': True, 06:47:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:47:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:47:37 INFO - 'opt_config_files': (), 06:47:37 INFO - 'pip_index': False, 06:47:37 INFO - 'sps_profile': False, 06:47:37 INFO - 'sps_profile_interval': 0, 06:47:37 INFO - 'suite': 'dromaeojs-e10s', 06:47:37 INFO - 'system_bits': '64', 06:47:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:47:37 INFO - 'title': 'talos-linux64-ix-022', 06:47:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:47:37 INFO - 'use_talos_json': True, 06:47:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:47:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:47:37 INFO - 'work_dir': 'build'} 06:47:37 INFO - ##### 06:47:37 INFO - ##### Running clobber step. 06:47:37 INFO - ##### 06:47:37 INFO - Running pre-action listener: _resource_record_pre_action 06:47:37 INFO - Running main action method: clobber 06:47:37 INFO - rmtree: /builds/slave/test/build 06:47:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:47:37 INFO - Running post-action listener: _resource_record_post_action 06:47:37 INFO - ##### 06:47:37 INFO - ##### Running read-buildbot-config step. 06:47:37 INFO - ##### 06:47:37 INFO - Running pre-action listener: _resource_record_pre_action 06:47:37 INFO - Running main action method: read_buildbot_config 06:47:37 INFO - Using buildbot properties: 06:47:37 INFO - { 06:47:37 INFO - "properties": { 06:47:37 INFO - "buildnumber": 471, 06:47:37 INFO - "product": "firefox", 06:47:37 INFO - "script_repo_revision": "production", 06:47:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:47:37 INFO - "repository": "", 06:47:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 06:47:37 INFO - "buildid": "20151127060814", 06:47:37 INFO - "slavename": "talos-linux64-ix-022", 06:47:37 INFO - "pgo_build": "False", 06:47:37 INFO - "basedir": "/builds/slave/test", 06:47:37 INFO - "project": "", 06:47:37 INFO - "platform": "ubuntu64_hw", 06:47:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:47:37 INFO - "slavebuilddir": "test", 06:47:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:47:37 INFO - "branch": "fx-team", 06:47:37 INFO - "repo_path": "integration/fx-team", 06:47:37 INFO - "stage_platform": "linux64", 06:47:37 INFO - "builduid": "abc686468f0747af9fa342c65131b86d", 06:47:37 INFO - "revision": "958669938c10f37112896f1f47e8ed8074c1495d" 06:47:37 INFO - }, 06:47:37 INFO - "sourcestamp": { 06:47:37 INFO - "repository": "", 06:47:37 INFO - "hasPatch": false, 06:47:37 INFO - "project": "", 06:47:37 INFO - "branch": "fx-team-linux64-talos", 06:47:37 INFO - "changes": [ 06:47:37 INFO - { 06:47:37 INFO - "category": null, 06:47:37 INFO - "files": [ 06:47:37 INFO - { 06:47:37 INFO - "url": null, 06:47:37 INFO - "name": "https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:47:37 INFO - } 06:47:37 INFO - ], 06:47:37 INFO - "repository": "", 06:47:37 INFO - "rev": "958669938c10f37112896f1f47e8ed8074c1495d", 06:47:37 INFO - "who": "mdeboer@mozilla.com", 06:47:37 INFO - "when": 1448635606, 06:47:37 INFO - "number": 6714985, 06:47:37 INFO - "comments": "Bug 1225832: fix UITour unit tests for Loop without navigator.mozLoop present. r=Standard8", 06:47:37 INFO - "project": "", 06:47:37 INFO - "at": "Fri 27 Nov 2015 06:46:46", 06:47:37 INFO - "branch": "fx-team-linux64-talos", 06:47:37 INFO - "revlink": "", 06:47:37 INFO - "properties": [ 06:47:37 INFO - [ 06:47:37 INFO - "buildid", 06:47:37 INFO - "20151127060814", 06:47:37 INFO - "Change" 06:47:37 INFO - ], 06:47:37 INFO - [ 06:47:37 INFO - "builduid", 06:47:37 INFO - "abc686468f0747af9fa342c65131b86d", 06:47:37 INFO - "Change" 06:47:37 INFO - ], 06:47:37 INFO - [ 06:47:37 INFO - "pgo_build", 06:47:37 INFO - "False", 06:47:37 INFO - "Change" 06:47:37 INFO - ] 06:47:37 INFO - ], 06:47:37 INFO - "revision": "958669938c10f37112896f1f47e8ed8074c1495d" 06:47:37 INFO - } 06:47:37 INFO - ], 06:47:37 INFO - "revision": "958669938c10f37112896f1f47e8ed8074c1495d" 06:47:37 INFO - } 06:47:37 INFO - } 06:47:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:47:37 INFO - Running post-action listener: _resource_record_post_action 06:47:37 INFO - ##### 06:47:37 INFO - ##### Running download-and-extract step. 06:47:37 INFO - ##### 06:47:37 INFO - Running pre-action listener: _resource_record_pre_action 06:47:37 INFO - Running main action method: download_and_extract 06:47:37 INFO - mkdir: /builds/slave/test/build/tests 06:47:37 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')]} 06:47:37 INFO - https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:47:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/test_packages.json 06:47:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/test_packages.json 06:47:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:47:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:47:45 INFO - Downloaded 1302 bytes. 06:47:45 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:47:45 INFO - Using the following test package requirements: 06:47:45 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:47:45 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:47:45 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'jsshell-linux-x86_64.zip'], 06:47:45 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:47:45 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:47:45 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:47:45 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:47:45 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:47:45 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:47:45 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:47:45 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:47:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:45 INFO - https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/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 06:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/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 06:47:46 INFO - Downloaded 21518599 bytes. 06:47:46 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 06:47:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:46 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 06:47:47 INFO - Return code: 0 06:47:47 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 06:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:47 INFO - https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/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 06:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/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 06:47:49 INFO - Downloaded 21518599 bytes. 06:47:49 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 06:47:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:47:49 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 06:47:50 INFO - Return code: 0 06:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:50 INFO - https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:47:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:47:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:47:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/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 06:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/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 06:47:52 INFO - Downloaded 11131728 bytes. 06:47:52 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 06:47:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:47:52 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 06:47:53 INFO - Return code: 0 06:47:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:53 INFO - https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:47:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:47:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:47:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/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 06:47:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbe5Z02KRv-fZVmJKVB6DA/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 06:47:54 INFO - Downloaded 56877606 bytes. 06:47:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:47:54 INFO - mkdir: /builds/slave/test/properties 06:47:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:47:54 INFO - Writing to file /builds/slave/test/properties/build_url 06:47:54 INFO - Contents: 06:47:54 INFO - build_url:https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:47:54 INFO - Running post-action listener: _resource_record_post_action 06:47:54 INFO - Running post-action listener: set_extra_try_arguments 06:47:54 INFO - ##### 06:47:54 INFO - ##### Running populate-webroot step. 06:47:54 INFO - ##### 06:47:54 INFO - Running pre-action listener: _resource_record_pre_action 06:47:54 INFO - Running main action method: populate_webroot 06:47:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:47:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:47:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:47:54 INFO - '../fennec_ids.txt'], 06:47:54 INFO - 'tests': ['tcheck2']}, 06:47:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:47:54 INFO - '--tppagecycles', 06:47:54 INFO - '7'], 06:47:54 INFO - 'tests': ['tsvgm']}}, 06:47:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:47:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:47:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:47:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:47:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:47:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:47:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:54 INFO - 'talos_options': ['--e10s'], 06:47:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:54 INFO - 'tests': ['damp', 'tps']}, 06:47:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:54 INFO - 'talos_options': ['--e10s'], 06:47:54 INFO - 'tests': ['damp', 'tps']}, 06:47:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:47:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:47:54 INFO - 'other': {'tests': ['a11yr', 06:47:54 INFO - 'ts_paint', 06:47:54 INFO - 'tpaint', 06:47:54 INFO - 'sessionrestore', 06:47:54 INFO - 'sessionrestore_no_auto_restore']}, 06:47:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:47:54 INFO - 'tests': ['a11yr', 06:47:54 INFO - 'ts_paint', 06:47:54 INFO - 'tpaint', 06:47:54 INFO - 'sessionrestore', 06:47:54 INFO - 'sessionrestore_no_auto_restore']}, 06:47:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:47:54 INFO - 'tests': ['a11yr', 06:47:54 INFO - 'ts_paint', 06:47:54 INFO - 'tpaint', 06:47:54 INFO - 'sessionrestore', 06:47:54 INFO - 'sessionrestore_no_auto_restore']}, 06:47:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:47:54 INFO - 'tests': ['a11yr', 06:47:54 INFO - 'ts_paint', 06:47:54 INFO - 'tpaint', 06:47:54 INFO - 'sessionrestore', 06:47:54 INFO - 'sessionrestore_no_auto_restore']}, 06:47:54 INFO - 'other_l64': {'tests': ['a11yr', 06:47:54 INFO - 'ts_paint', 06:47:54 INFO - 'tpaint', 06:47:54 INFO - 'sessionrestore', 06:47:54 INFO - 'sessionrestore_no_auto_restore']}, 06:47:54 INFO - 'other_nol64': {'tests': ['a11yr', 06:47:54 INFO - 'ts_paint', 06:47:54 INFO - 'tpaint', 06:47:54 INFO - 'sessionrestore', 06:47:54 INFO - 'sessionrestore_no_auto_restore']}, 06:47:54 INFO - 'svgr': {'tests': ['tsvgx', 06:47:54 INFO - 'tsvgr_opacity', 06:47:54 INFO - 'tart', 06:47:54 INFO - 'tscrollx', 06:47:54 INFO - 'cart']}, 06:47:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:47:54 INFO - 'tests': ['tsvgx', 06:47:54 INFO - 'tsvgr_opacity', 06:47:54 INFO - 'tart', 06:47:54 INFO - 'tscrollx', 06:47:54 INFO - 'cart']}, 06:47:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:54 INFO - 'tests': ['tp5o']}, 06:47:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:54 INFO - 'talos_options': ['--e10s'], 06:47:54 INFO - 'tests': ['tp5o']}, 06:47:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:54 INFO - 'talos_options': ['--xperf_path', 06:47:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:54 INFO - 'tests': ['tp5n']}, 06:47:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:54 INFO - 'talos_options': ['--e10s', 06:47:54 INFO - '--xperf_path', 06:47:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:54 INFO - 'tests': ['tp5n']}}, 06:47:54 INFO - 'talos.zip': {'path': '', 06:47:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:47:54 INFO - Running post-action listener: _resource_record_post_action 06:47:54 INFO - ##### 06:47:54 INFO - ##### Running create-virtualenv step. 06:47:54 INFO - ##### 06:47:54 INFO - Running pre-action listener: _resource_record_pre_action 06:47:54 INFO - Running main action method: create_virtualenv 06:47:54 INFO - Creating virtualenv /builds/slave/test/build/venv 06:47:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:47:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:47:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:47:54 INFO - Using real prefix '/usr' 06:47:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:47:55 INFO - Installing distribute.............................................................................................................................................................................................done. 06:47:57 INFO - Installing pip.................done. 06:47:57 INFO - Return code: 0 06:47:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19cc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2710240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', '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 06:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:47:57 INFO - Using env: {'DISPLAY': ':0', 06:47:57 INFO - 'HOME': '/home/cltbld', 06:47:57 INFO - 'LANG': 'en_US.UTF-8', 06:47:57 INFO - 'LANGUAGE': 'en_US:en', 06:47:57 INFO - 'LOGNAME': 'cltbld', 06:47:57 INFO - 'MAIL': '/var/mail/cltbld', 06:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:57 INFO - 'MOZ_NO_REMOTE': '1', 06:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:57 INFO - 'NO_EM_RESTART': '1', 06:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:57 INFO - 'PWD': '/builds/slave/test', 06:47:57 INFO - 'SHELL': '/bin/bash', 06:47:57 INFO - 'SHLVL': '1', 06:47:57 INFO - 'TERM': 'linux', 06:47:57 INFO - 'TMOUT': '86400', 06:47:57 INFO - 'USER': 'cltbld', 06:47:57 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:57 INFO - '_': '/tools/buildbot/bin/python'} 06:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:47:57 INFO - Cleaning up... 06:47:57 INFO - Return code: 0 06:47:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19cc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2710240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', '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 06:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:47:57 INFO - Using env: {'DISPLAY': ':0', 06:47:57 INFO - 'HOME': '/home/cltbld', 06:47:57 INFO - 'LANG': 'en_US.UTF-8', 06:47:57 INFO - 'LANGUAGE': 'en_US:en', 06:47:57 INFO - 'LOGNAME': 'cltbld', 06:47:57 INFO - 'MAIL': '/var/mail/cltbld', 06:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:57 INFO - 'MOZ_NO_REMOTE': '1', 06:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:57 INFO - 'NO_EM_RESTART': '1', 06:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:57 INFO - 'PWD': '/builds/slave/test', 06:47:57 INFO - 'SHELL': '/bin/bash', 06:47:57 INFO - 'SHLVL': '1', 06:47:57 INFO - 'TERM': 'linux', 06:47:57 INFO - 'TMOUT': '86400', 06:47:57 INFO - 'USER': 'cltbld', 06:47:57 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:57 INFO - '_': '/tools/buildbot/bin/python'} 06:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:57 INFO - Downloading/unpacking psutil>=0.7.1 06:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:47:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:47:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:59 INFO - Installing collected packages: psutil 06:47:59 INFO - Running setup.py install for psutil 06:47:59 INFO - building 'psutil._psutil_linux' extension 06:47:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:47:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:47:59 INFO - building 'psutil._psutil_posix' extension 06:47:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:47:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:47:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:59 INFO - Successfully installed psutil 06:47:59 INFO - Cleaning up... 06:47:59 INFO - Return code: 0 06:47:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:47:59 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')]} 06:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:59 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')]} 06:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:59 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 0x7fa19cc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2710240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', '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 06:47:59 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 06:47:59 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 06:47:59 INFO - Using env: {'DISPLAY': ':0', 06:47:59 INFO - 'HOME': '/home/cltbld', 06:47:59 INFO - 'LANG': 'en_US.UTF-8', 06:47:59 INFO - 'LANGUAGE': 'en_US:en', 06:47:59 INFO - 'LOGNAME': 'cltbld', 06:47:59 INFO - 'MAIL': '/var/mail/cltbld', 06:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:59 INFO - 'MOZ_NO_REMOTE': '1', 06:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:59 INFO - 'NO_EM_RESTART': '1', 06:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:59 INFO - 'PWD': '/builds/slave/test', 06:47:59 INFO - 'SHELL': '/bin/bash', 06:47:59 INFO - 'SHLVL': '1', 06:47:59 INFO - 'TERM': 'linux', 06:47:59 INFO - 'TMOUT': '86400', 06:47:59 INFO - 'USER': 'cltbld', 06:47:59 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:59 INFO - '_': '/tools/buildbot/bin/python'} 06:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:48:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:48:01 INFO - Installing collected packages: mozsystemmonitor 06:48:01 INFO - Running setup.py install for mozsystemmonitor 06:48:01 INFO - Successfully installed mozsystemmonitor 06:48:01 INFO - Cleaning up... 06:48:01 INFO - Return code: 0 06:48:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa19cc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2710240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', '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 06:48:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:48:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:48:01 INFO - Using env: {'DISPLAY': ':0', 06:48:01 INFO - 'HOME': '/home/cltbld', 06:48:01 INFO - 'LANG': 'en_US.UTF-8', 06:48:01 INFO - 'LANGUAGE': 'en_US:en', 06:48:01 INFO - 'LOGNAME': 'cltbld', 06:48:01 INFO - 'MAIL': '/var/mail/cltbld', 06:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:01 INFO - 'MOZ_NO_REMOTE': '1', 06:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:01 INFO - 'NO_EM_RESTART': '1', 06:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:01 INFO - 'PWD': '/builds/slave/test', 06:48:01 INFO - 'SHELL': '/bin/bash', 06:48:01 INFO - 'SHLVL': '1', 06:48:01 INFO - 'TERM': 'linux', 06:48:01 INFO - 'TMOUT': '86400', 06:48:01 INFO - 'USER': 'cltbld', 06:48:01 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:01 INFO - '_': '/tools/buildbot/bin/python'} 06:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:02 INFO - Downloading/unpacking blobuploader==1.2.4 06:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:03 INFO - Downloading blobuploader-1.2.4.tar.gz 06:48:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:48:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:48:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:04 INFO - Downloading docopt-0.6.1.tar.gz 06:48:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:48:04 INFO - Installing collected packages: blobuploader, requests, docopt 06:48:04 INFO - Running setup.py install for blobuploader 06:48:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:48:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:48:04 INFO - Running setup.py install for requests 06:48:05 INFO - Running setup.py install for docopt 06:48:05 INFO - Successfully installed blobuploader requests docopt 06:48:05 INFO - Cleaning up... 06:48:05 INFO - Return code: 0 06:48:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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')]} 06:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19cc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2710240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', '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 06:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:48:05 INFO - Using env: {'DISPLAY': ':0', 06:48:05 INFO - 'HOME': '/home/cltbld', 06:48:05 INFO - 'LANG': 'en_US.UTF-8', 06:48:05 INFO - 'LANGUAGE': 'en_US:en', 06:48:05 INFO - 'LOGNAME': 'cltbld', 06:48:05 INFO - 'MAIL': '/var/mail/cltbld', 06:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:05 INFO - 'MOZ_NO_REMOTE': '1', 06:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:05 INFO - 'NO_EM_RESTART': '1', 06:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:05 INFO - 'PWD': '/builds/slave/test', 06:48:05 INFO - 'SHELL': '/bin/bash', 06:48:05 INFO - 'SHLVL': '1', 06:48:05 INFO - 'TERM': 'linux', 06:48:05 INFO - 'TMOUT': '86400', 06:48:05 INFO - 'USER': 'cltbld', 06:48:05 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:05 INFO - '_': '/tools/buildbot/bin/python'} 06:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:05 INFO - Running setup.py (path:/tmp/pip-ezANK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:05 INFO - Running setup.py (path:/tmp/pip-O3RPTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:05 INFO - Running setup.py (path:/tmp/pip-mZPM66-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:05 INFO - Running setup.py (path:/tmp/pip-kCnrXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:05 INFO - Running setup.py (path:/tmp/pip-wUXhV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:05 INFO - Running setup.py (path:/tmp/pip-zCSblM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:05 INFO - Running setup.py (path:/tmp/pip-6CqbHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:05 INFO - Running setup.py (path:/tmp/pip-CRdReU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:05 INFO - Running setup.py (path:/tmp/pip-e_ZYmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:06 INFO - Running setup.py (path:/tmp/pip-In8wym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:06 INFO - Running setup.py (path:/tmp/pip-MDmWGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:06 INFO - Running setup.py (path:/tmp/pip-ssBXOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:06 INFO - Running setup.py (path:/tmp/pip-eWYoz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:06 INFO - Running setup.py (path:/tmp/pip-Xy1sTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:06 INFO - Running setup.py (path:/tmp/pip-f8GulI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:06 INFO - Running setup.py (path:/tmp/pip-1b2iVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:06 INFO - Running setup.py (path:/tmp/pip-gZob3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:48:06 INFO - Running setup.py install for manifestparser 06:48:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Running setup.py install for mozcrash 06:48:06 INFO - Running setup.py install for mozdebug 06:48:06 INFO - Running setup.py install for mozdevice 06:48:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozfile 06:48:07 INFO - Running setup.py install for mozhttpd 06:48:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozinfo 06:48:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozInstall 06:48:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozleak 06:48:07 INFO - Running setup.py install for mozlog 06:48:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for moznetwork 06:48:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozprocess 06:48:07 INFO - Running setup.py install for mozprofile 06:48:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Running setup.py install for mozrunner 06:48:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:48:08 INFO - Running setup.py install for mozscreenshot 06:48:08 INFO - Running setup.py install for moztest 06:48:08 INFO - Running setup.py install for mozversion 06:48:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:48:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:48:08 INFO - Cleaning up... 06:48:08 INFO - Return code: 0 06:48:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19cc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2710240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', '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 06:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:48:08 INFO - Using env: {'DISPLAY': ':0', 06:48:08 INFO - 'HOME': '/home/cltbld', 06:48:08 INFO - 'LANG': 'en_US.UTF-8', 06:48:08 INFO - 'LANGUAGE': 'en_US:en', 06:48:08 INFO - 'LOGNAME': 'cltbld', 06:48:08 INFO - 'MAIL': '/var/mail/cltbld', 06:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:08 INFO - 'MOZ_NO_REMOTE': '1', 06:48:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:08 INFO - 'NO_EM_RESTART': '1', 06:48:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:08 INFO - 'PWD': '/builds/slave/test', 06:48:08 INFO - 'SHELL': '/bin/bash', 06:48:08 INFO - 'SHLVL': '1', 06:48:08 INFO - 'TERM': 'linux', 06:48:08 INFO - 'TMOUT': '86400', 06:48:08 INFO - 'USER': 'cltbld', 06:48:08 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:08 INFO - '_': '/tools/buildbot/bin/python'} 06:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:08 INFO - Running setup.py (path:/tmp/pip-_STxmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:08 INFO - Running setup.py (path:/tmp/pip-6uhKnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:08 INFO - Running setup.py (path:/tmp/pip-d704Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:08 INFO - Running setup.py (path:/tmp/pip-PofKT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:08 INFO - Running setup.py (path:/tmp/pip-WEiwM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:08 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)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:08 INFO - Running setup.py (path:/tmp/pip-7HT66f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:09 INFO - Running setup.py (path:/tmp/pip-G29jZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:09 INFO - Running setup.py (path:/tmp/pip-Vfee1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:09 INFO - Running setup.py (path:/tmp/pip-wSdkC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:09 INFO - Running setup.py (path:/tmp/pip-Fm_SiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:09 INFO - Running setup.py (path:/tmp/pip-8fDSPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:09 INFO - Running setup.py (path:/tmp/pip-3olBU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:09 INFO - Running setup.py (path:/tmp/pip-GNLLRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:09 INFO - Running setup.py (path:/tmp/pip-a5N5Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:09 INFO - Running setup.py (path:/tmp/pip-0Drrar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:09 INFO - Running setup.py (path:/tmp/pip-Yr7lAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:09 INFO - Running setup.py (path:/tmp/pip-pGBQ8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:09 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)) 06:48:09 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)) 06:48:09 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)) 06:48:09 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)) 06:48:09 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)) 06:48:09 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)) 06:48:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:11 INFO - Downloading blessings-1.5.1.tar.gz 06:48:11 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 06:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:48:11 INFO - Installing collected packages: blessings 06:48:11 INFO - Running setup.py install for blessings 06:48:11 INFO - Successfully installed blessings 06:48:11 INFO - Cleaning up... 06:48:11 INFO - Return code: 0 06:48:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:48:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:11 INFO - Reading from file tmpfile_stdout 06:48:11 INFO - Current package versions: 06:48:11 INFO - argparse == 1.2.1 06:48:11 INFO - blessings == 1.5.1 06:48:11 INFO - blobuploader == 1.2.4 06:48:11 INFO - docopt == 0.6.1 06:48:11 INFO - manifestparser == 1.1 06:48:11 INFO - mozInstall == 1.12 06:48:11 INFO - mozcrash == 0.16 06:48:11 INFO - mozdebug == 0.1 06:48:11 INFO - mozdevice == 0.47 06:48:11 INFO - mozfile == 1.2 06:48:11 INFO - mozhttpd == 0.7 06:48:11 INFO - mozinfo == 0.9 06:48:11 INFO - mozleak == 0.1 06:48:11 INFO - mozlog == 3.1 06:48:11 INFO - moznetwork == 0.27 06:48:11 INFO - mozprocess == 0.22 06:48:11 INFO - mozprofile == 0.27 06:48:11 INFO - mozrunner == 6.11 06:48:11 INFO - mozscreenshot == 0.1 06:48:11 INFO - mozsystemmonitor == 0.0 06:48:11 INFO - moztest == 0.7 06:48:11 INFO - mozversion == 1.4 06:48:11 INFO - psutil == 3.1.1 06:48:11 INFO - requests == 1.2.3 06:48:11 INFO - wsgiref == 0.1.2 06:48:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:11 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')]} 06:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:11 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')]} 06:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:11 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 0x7fa19cc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2710240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', '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 06:48:11 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 06:48:11 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 06:48:11 INFO - Using env: {'DISPLAY': ':0', 06:48:11 INFO - 'HOME': '/home/cltbld', 06:48:11 INFO - 'LANG': 'en_US.UTF-8', 06:48:11 INFO - 'LANGUAGE': 'en_US:en', 06:48:11 INFO - 'LOGNAME': 'cltbld', 06:48:11 INFO - 'MAIL': '/var/mail/cltbld', 06:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:11 INFO - 'MOZ_NO_REMOTE': '1', 06:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:11 INFO - 'NO_EM_RESTART': '1', 06:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:11 INFO - 'PWD': '/builds/slave/test', 06:48:11 INFO - 'SHELL': '/bin/bash', 06:48:11 INFO - 'SHLVL': '1', 06:48:11 INFO - 'TERM': 'linux', 06:48:11 INFO - 'TMOUT': '86400', 06:48:11 INFO - 'USER': 'cltbld', 06:48:11 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:11 INFO - '_': '/tools/buildbot/bin/python'} 06:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:48:12 INFO - Cleaning up... 06:48:12 INFO - Return code: 0 06:48:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19cc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2710240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', '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 06:48:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:48:12 INFO - Using env: {'DISPLAY': ':0', 06:48:12 INFO - 'HOME': '/home/cltbld', 06:48:12 INFO - 'LANG': 'en_US.UTF-8', 06:48:12 INFO - 'LANGUAGE': 'en_US:en', 06:48:12 INFO - 'LOGNAME': 'cltbld', 06:48:12 INFO - 'MAIL': '/var/mail/cltbld', 06:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:12 INFO - 'MOZ_NO_REMOTE': '1', 06:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:12 INFO - 'NO_EM_RESTART': '1', 06:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:12 INFO - 'PWD': '/builds/slave/test', 06:48:12 INFO - 'SHELL': '/bin/bash', 06:48:12 INFO - 'SHLVL': '1', 06:48:12 INFO - 'TERM': 'linux', 06:48:12 INFO - 'TMOUT': '86400', 06:48:12 INFO - 'USER': 'cltbld', 06:48:12 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:12 INFO - '_': '/tools/buildbot/bin/python'} 06:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:12 INFO - Downloading/unpacking jsonschema 06:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:48:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 06:48:14 INFO - Downloading/unpacking functools32 (from jsonschema) 06:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:14 INFO - Downloading functools32-3.2.3-2.tar.gz 06:48:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 06:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:48:14 INFO - warning: no files found matching '*.txt' 06:48:14 INFO - no previously-included directories found matching 'build' 06:48:14 INFO - no previously-included directories found matching 'dist' 06:48:14 INFO - no previously-included directories found matching '.git*' 06:48:14 INFO - Installing collected packages: jsonschema, functools32 06:48:14 INFO - Running setup.py install for functools32 06:48:14 INFO - warning: no files found matching '*.txt' 06:48:14 INFO - no previously-included directories found matching 'build' 06:48:14 INFO - no previously-included directories found matching 'dist' 06:48:14 INFO - no previously-included directories found matching '.git*' 06:48:14 INFO - Successfully installed jsonschema functools32 06:48:14 INFO - Cleaning up... 06:48:14 INFO - Return code: 0 06:48:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:48: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')]} 06:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48: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')]} 06:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19cc1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26428a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2710240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', '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 06:48:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:48:14 INFO - Using env: {'DISPLAY': ':0', 06:48:14 INFO - 'HOME': '/home/cltbld', 06:48:14 INFO - 'LANG': 'en_US.UTF-8', 06:48:14 INFO - 'LANGUAGE': 'en_US:en', 06:48:14 INFO - 'LOGNAME': 'cltbld', 06:48:14 INFO - 'MAIL': '/var/mail/cltbld', 06:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:14 INFO - 'MOZ_NO_REMOTE': '1', 06:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:14 INFO - 'NO_EM_RESTART': '1', 06:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:14 INFO - 'PWD': '/builds/slave/test', 06:48:14 INFO - 'SHELL': '/bin/bash', 06:48:14 INFO - 'SHLVL': '1', 06:48:14 INFO - 'TERM': 'linux', 06:48:14 INFO - 'TMOUT': '86400', 06:48:14 INFO - 'USER': 'cltbld', 06:48:14 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:14 INFO - '_': '/tools/buildbot/bin/python'} 06:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:14 INFO - Downloading/unpacking flake8 06:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:48:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 06:48:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:48:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 06:48:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 06:48:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 06:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:48:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:48:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:48:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:48:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:48:17 INFO - no previously-included directories found matching 'docs/_build' 06:48:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:48:17 INFO - Running setup.py install for pep8 06:48:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:48:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:48:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:48:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:48:17 INFO - no previously-included directories found matching 'docs/_build' 06:48:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:48:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:48:17 INFO - Cleaning up... 06:48:17 INFO - Return code: 0 06:48:17 INFO - Running post-action listener: _resource_record_post_action 06:48:17 INFO - Running post-action listener: _start_resource_monitoring 06:48:17 INFO - Starting resource monitoring. 06:48:17 INFO - ##### 06:48:17 INFO - ##### Running install step. 06:48:17 INFO - ##### 06:48:17 INFO - Running pre-action listener: _resource_record_pre_action 06:48:17 INFO - Running main action method: install 06:48:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:17 INFO - Reading from file tmpfile_stdout 06:48:17 INFO - Detecting whether we're running mozinstall >=1.0... 06:48:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:48:17 INFO - Reading from file tmpfile_stdout 06:48:17 INFO - Output received: 06:48:17 INFO - Usage: mozinstall [options] installer 06:48:17 INFO - Options: 06:48:17 INFO - -h, --help show this help message and exit 06:48:17 INFO - -d DEST, --destination=DEST 06:48:17 INFO - Directory to install application into. [default: 06:48:17 INFO - "/builds/slave/test"] 06:48:17 INFO - --app=APP Application being installed. [default: firefox] 06:48:17 INFO - mkdir: /builds/slave/test/build/application 06:48:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:48:31 INFO - Reading from file tmpfile_stdout 06:48:31 INFO - Output received: 06:48:31 INFO - /builds/slave/test/build/application/firefox/firefox 06:48:31 INFO - Running post-action listener: _resource_record_post_action 06:48:31 INFO - ##### 06:48:31 INFO - ##### Running run-tests step. 06:48:31 INFO - ##### 06:48:31 INFO - Running pre-action listener: _resource_record_pre_action 06:48:31 INFO - Running main action method: run_tests 06:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:48:31 INFO - Python 2.7.3 06:48:31 INFO - Return code: 0 06:48:31 INFO - grabbing minidump binary from tooltool 06:48:31 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')]} 06:48:31 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 0x279f0b0>, '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 0x279ffb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27a0440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:48:31 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 06:48:31 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 06:48:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:48:31 INFO - Return code: 0 06:48:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:48:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:48:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:48:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:48:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:48:32 INFO - Return code: 0 06:48:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test/build 06:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 06:48:32 INFO - Using env: {'DISPLAY': ':0', 06:48:32 INFO - 'HOME': '/home/cltbld', 06:48:32 INFO - 'LANG': 'en_US.UTF-8', 06:48:32 INFO - 'LANGUAGE': 'en_US:en', 06:48:32 INFO - 'LOGNAME': 'cltbld', 06:48:32 INFO - 'MAIL': '/var/mail/cltbld', 06:48:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:48:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:32 INFO - 'MOZ_NO_REMOTE': '1', 06:48:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:32 INFO - 'NO_EM_RESTART': '1', 06:48:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:32 INFO - 'PWD': '/builds/slave/test', 06:48:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:48:32 INFO - 'SHELL': '/bin/bash', 06:48:32 INFO - 'SHLVL': '1', 06:48:32 INFO - 'TERM': 'linux', 06:48:32 INFO - 'TMOUT': '86400', 06:48:32 INFO - 'USER': 'cltbld', 06:48:32 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232', 06:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:32 INFO - '_': '/tools/buildbot/bin/python'} 06:48:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 06:48:33 INFO - mozversion INFO | application_buildid: 20151127060814 06:48:33 INFO - mozversion INFO | application_changeset: 958669938c10f37112896f1f47e8ed8074c1495d 06:48:33 INFO - mozversion INFO | application_display_name: Nightly 06:48:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:48:33 INFO - mozversion INFO | application_name: Firefox 06:48:33 INFO - mozversion INFO | application_remotingname: firefox 06:48:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 06:48:33 INFO - mozversion INFO | application_vendor: Mozilla 06:48:33 INFO - mozversion INFO | application_version: 45.0a1 06:48:33 INFO - mozversion INFO | platform_buildid: 20151127060814 06:48:33 INFO - mozversion INFO | platform_changeset: 958669938c10f37112896f1f47e8ed8074c1495d 06:48:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 06:48:33 INFO - mozversion INFO | platform_version: 45.0a1 06:48:33 INFO - 2015-11-27 06:48:33,102 DEBUG : using testdate: 1448635713 06:48:33 INFO - 2015-11-27 06:48:33,102 DEBUG : actual date: 1448635713 06:48:33 INFO - 2015-11-27 06:48:33,117 INFO : starting webserver on 'localhost:47250' 06:48:33 INFO - 2015-11-27 06:48:33,118 INFO : Starting test suite talos-linux64-ix-022.e 06:48:33 INFO - 2015-11-27 06:48:33,118 INFO : Starting test dromaeo_css 06:48:33 INFO - 2015-11-27 06:48:33,119 DEBUG : operating with platform_type : linux_ 06:48:33 INFO - 2015-11-27 06:48:33,119 INFO : Initialising browser for dromaeo_css test... 06:48:33 INFO - 2015-11-27 06:48:33,136 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_pZh1K/profile http://localhost:47250/getInfo.html 06:48:38 INFO - 2015-11-27 06:48:38,687 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:48:38 INFO - 2015-11-27 06:48:38,687 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:48:38 INFO - 2015-11-27 06:48:38,687 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:48:38 INFO - 2015-11-27 06:48:38,687 DEBUG : BROWSER_OUTPUT: __metrics 06:48:39 INFO - 2015-11-27 06:48:39,801 INFO : Browser initialized. 06:48:39 INFO - 2015-11-27 06:48:39,802 INFO : Running cycle 1/1 for dromaeo_css test... 06:48:39 INFO - 2015-11-27 06:48:39,802 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_pZh1K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:48:51 INFO - 2015-11-27 06:48:51,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 138620928 06:48:51 INFO - 2015-11-27 06:48:51,761 DEBUG : BROWSER_OUTPUT: 06:49:41 INFO - 2015-11-27 06:49:41,424 DEBUG : BROWSER_OUTPUT: 1448635781416 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] 06:51:53 INFO - 2015-11-27 06:51:53,026 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47250/tests/dromaeo/cssquery-ext.html) 06:51:54 INFO - 2015-11-27 06:51:54,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 146231296 06:51:54 INFO - 2015-11-27 06:51:54,131 DEBUG : BROWSER_OUTPUT: 06:54:56 INFO - 2015-11-27 06:54:56,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/dromaeo/cssquery-ext.html (next: http://localhost:47250/tests/dromaeo/cssquery-jquery.html) 06:54:56 INFO - 2015-11-27 06:54:56,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 143228928 06:54:56 INFO - 2015-11-27 06:54:56,872 DEBUG : BROWSER_OUTPUT: 06:57:58 INFO - 2015-11-27 06:57:58,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47250/tests/dromaeo/cssquery-mootools.html) 06:57:59 INFO - 2015-11-27 06:57:59,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 144515072 06:57:59 INFO - 2015-11-27 06:57:59,226 DEBUG : BROWSER_OUTPUT: 07:01:00 INFO - 2015-11-27 07:01:00,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47250/tests/dromaeo/cssquery-prototype.html) 07:01:01 INFO - 2015-11-27 07:01:01,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 140931072 07:01:01 INFO - 2015-11-27 07:01:01,597 DEBUG : BROWSER_OUTPUT: 07:04:04 INFO - 2015-11-27 07:04:04,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47250/tests/dromaeo/cssquery-yui.html) 07:04:04 INFO - 2015-11-27 07:04:04,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 141324288 07:04:04 INFO - 2015-11-27 07:04:04,725 DEBUG : BROWSER_OUTPUT: 07:07:07 INFO - 2015-11-27 07:07:07,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/dromaeo/cssquery-yui.html (next: http://localhost:47250/tests/dromaeo/cssquery-dojo.html) 07:07:07 INFO - 2015-11-27 07:07:07,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 145666048 07:07:07 INFO - 2015-11-27 07:07:07,437 DEBUG : BROWSER_OUTPUT: 07:07:07 INFO - 2015-11-27 07:07:07,439 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:07:07 INFO - 2015-11-27 07:07:07,439 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:07:07 INFO - 2015-11-27 07:07:07,439 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:07:07 INFO - 2015-11-27 07:07:07,439 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:07:07 INFO - 2015-11-27 07:07:07,441 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2615.712271650118;2677.919662410126;2711.295063283547;2725.01899316246;2728.658917635295;4513.323001549769;4661.79021944012;4695.929561056587;4702.412198475191;4742;4515.164694531514;4576.977115114428;4622.676412651116;4643.16423043852;4648.395708557883;4186.958130418688;4288.892777680552;4305.461817272841;4343.891402714926;4404.207242696313;4365.01787097902;4427.11457708458;4433.88915277119;4434.423524941753;4439.289713645818;4100.835966561334;4185.2885009548145;4269.701120921537;4273.786310684484;4273.893152671177;4339.349097635349;4346.804393802255;4367.3448982652535;4374.125174964988;4379.430674012358;4311.741295522279;4315.07225946423;4333.2200203963275;4345.674074444398;4377.277749171383;4270.658347332206;4373.912521749579;4395.274779661352;4398.230309695822;4659.790309436084;4850.514948505156;4941.802327906879;4956.058348913695;4962.62780291476;5003.324551185579;5087.872803179913;5110.310108135392;5120.462351453119;5121.180611102243;5180.248863914749;4511.70673906195;4654.2785868190485;4694.155052090622;4719.056188762262;4722.008378240539;5079.238114282887;5189.065968125774;5196.298499702568;5196.350456192976;5226.660267082628;4952.182889823139;4956.752162391866;4963.875903102451;4967.354243948336;5003.574696150795;4796.928046079312;4863.392075990501;4911.140550403665;5047.268146118792;5053.747312634354;4926.605871530269;4953.0589188054155;4975.900481990412;4982.551570358685;4987.925181122286;4950;4954.603631709455;4958.603311735053;4959.330490383824;4988.376452943382;4060.796960151981;4154.231467178582;4163.250614889349;4166.520850102216;4290.227759003409;3654.506641603403;3720.330340538675;3723.5345581802276;3740.6446387593137;3750.4186851038135;4335.739855608674;4337.9132417351475;4360.672949528798;4391.604755572014;4397.098594788061;4852.587530059985;4887.511248875155;4962.181240095416;5038.445770965191;5060.316857224301;4298.742075475481;4336.392904993303;4340.978295108567;4349.652027837766;4374.912501749947;4467.597916187558;4474.284114541722;4492.618127459137;4495.415595972503;4515.0518391137575;4585.105904348687;4607.285870690049;4695.671303008757;4698.8355407560575;4779.450363208275;4970.304157417892;4980.526849949249;5000.349954506037;5008.2738002988635;5064.139096353702;4698.530146985411;4711.952880471152;4712.387389639325;4739.52604739537;4744.88137796544;4719.0561887621925;4817.132916075;4857.805687772449;4863.90272194547;4875.390576177978;5037.471065538066;5041.168207245763;5058.898822023612;5064.037832811754;5068.543831055075;4895.73073480962;4900.975495122644;4905.5094490550655;4924.482929292372;4935.679180853233;4635.258358662598;4780.5697487224925;4791.880202994814;4903.803847846046;4926.039422312758;4725.740084295397;4752.881177970578;4773.904521909473;4774.283857421415;4791.952080479151;4831.975840120777;4868.6611181925255;4881.463039065629;4887.022595480847;4913.041956818386;4662.32396302541;4683.812647494062;4779.139754844023;4782;4796.592289655418 07:07:07 INFO - 2015-11-27 07:07:07,442 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.9663420194788;564.9180868774026;567.0332083797126;577.4975771079162;592.5111782779205;32452.350952980956;33041.17397065074;33099;33116.834415827914;33340.66659333406;38602;39021.609783902226;39078.21843563127;39255.60744392555;39426.40860387089;7884.999999999985;7949.6025198739835;8061.95969020157;8069.556174410405;8075.434719569633;7841.764747057598;7946.682132714714;7957.801054973614;7970.322522585587;8007.079185893609;7920.16838231986;8048.476849004796;8054.355651547862;8057.879131813028;8059.113497515298;7892.131865494791;7918.52488850665;7985.361171106327;7986.560739159344;8000.079990801074;7788.649510771972;7913.920860791433;7929.72245971394;7947.602619868983;7955.761327160194;34952;35426.645733542595;35766.642333576594;35783;35934.64065359339;2843.758280546156;2913.6357955255594;2941.3970136122043;3158.6051743532057;3276.7214786742916;27382.178534643994;27783.72216277852;27802.3049423764;27890.860545697346;27972.580411293846;3062.72330289798;3103.20868178613;3133.3263348380206;3154.763392745553;3164.810111393324;213758;214195.92902035546;215109;215635;215681;51267.48732512627;51280.743596281776;51296.23055654168;51642;51744.48255517472;61050.38949610447;62874;62909;63072;63139;12114.878851211375;12173.208741431956;12226;12269.69325766863;12273.938630306791;9245.768855778524;9350.672726454677;9374.85937710935;9391.906080939103;9427.76430589227;19295.614087718448;19386.321478748458;19459.708104378446;19484.297983383396;19510.122044508033;7675.2324767522805;7758.806029849186;7823.295903368724;7946.960265198637;7953.721619743281;814.242754238552;820.5938060659893;824.2540500846624;828.1552816127637;959.4770849886828;29771.85114074459;30871.84564077165;30990.845045775077;31008.22479438032;31452.842735786173;914.9313801464916;972.7519482531909;994.4928086675703;1045.0281238448165;1052.5737076484036;13592.320383980761;13612.795808062887;13892.16647001183;13921;13941.442342306396;329925;333923;334573;334745;336104;44924.77537612291;45633.54366456359;45734;45880.541194587626;45948;1163.6799880033059;1205.493692649072;1217.6407959651747;1221.4625564751482;1228.5822820240983;25003.49993000166;25501;25530.489390212464;26025.21924342273;26037.73962260429;38074.238515228986;38295;38358.80820595879;38722.41916371313;38841.41737873878;255370;256429;256598;257591;259073;28046;40087.198256034135;41937;42290.36564451474;42385.36421953735;37824.43263350997;38326.42510362291;38903.80548097241;38923.610763892;39499;32237.838810805795;33002.83498582492;33091.33817323592;33608.83195584006;33722.66277337195;35563.466548001285;36011.819940900124;37318.62681373151;37924.81037594794;38214;33772.155696107795;33911.491327629614;37264.813675931444;37928.05179870525;38011.61988380191;28401.715982840735;30242.54636180503;31867.681323186473;33843.830780845936;33973.66026339804;23500.177493787636;23780.286591402284;23830.642540362256;24082.277531674077;25478.23565293044 07:07:07 INFO - 2015-11-27 07:07:07,445 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.51725859435066;317.4127863452613;318.8405797101449;319.70107949067636;323.9902802915913;14977.775333370008;15164.848351516468;15413.306401211945;15892.205389730496;16458.423955161572;8455.069942306342;8643.265322447583;10309.690709278715;14884;15063;4161.854335098272;4205.663546916247;4297.9570204298025;4317.654587632997;4321.157374312011;4274.29474136767;4310.245707001278;4313.719608225455;4316.54676258993;4336.479622445311;4346.56534346566;4361.716488428257;4495.887602809939;4648.279516674921;4650.883727906812;3727.9440808387894;4696.131215725101;4696.812127514895;4729.905401891943;4735.147673418784;4449.221386257392;4571.565701258375;4572.977135114336;4573.039661671053;4586.220342541743;9364.812703745954;9441.716748497556;9442.38624489406;9741.269404794597;9885.555150018266;1715.9605121147006;1729.3082766893217;1746.240385432341;1785.6785778559854;1921.702136168896;7978.680852765882;8086.110527841933;8195.262426381594;8232.794180145544;8275.337972962148;1644.4902080355128;1715.8284171582866;1729.44657709533;1758.832910873465;1809.2672467650623;52227.47772522264;52257;53374.73312633451;54491.45508544904;55933.72033139849;9085.81828363429;9312;9388;9451.338406311492;9479.336446448682;11709.76580468403;11807.822882656767;11886.940565297118;11887.16789824704;11891.643250702493;6394.23269207698;6507.609543427409;6550.050242714779;6628.403443689995;6685.231198412245;5858.2677165354335;5876.647401155944;5907.261592300963;5915.40845915405;5943.851403714855;3427.7429192810637;3428.708559772397;3869.993801611601;3898.922021559553;3918.2359439909515;1575.8030246219223;1671.5821044738816;1674.4641714651195;1677.2536221381367;1677.5386768638723;708.840510885057;835.8370117827087;840.630122746002;906.8347173881531;972.3485264872552;14927.477538286324;15201.315940782692;15525.922370388076;15643.765343519857;16496.587585310222;800.4116974024088;807.9798005049921;826.8222332198607;833.1168960901342;858.6737039924789;7693;8354.791130221793;8393.286570641441;8616.224539791448;9090.90909090914;503407;505488;507492;515635;521072;70720.2927970724;72721;73353.6332318335;73413.26586734172;73615;1050.6952983634812;1055.9366438013744;1072.1262171330497;1100.6808025672465;1117.1398023521842;13462.798058028942;14219.50231741884;14277.42890284377;14386.856131438552;14496.565103046925;32514.674853251163;32652.020439386855;32739.181520462178;32931.67068329382;33030.50454243236;39965;40434;41655.37516937188;41672;42000.36999445072;7913.643886025257;8183.754487365389;8901;8949.373543851867;9034.954825225832;15715;16053.19734013318;16163;16218.837811621734;16387.83612163863;13785.862141378459;13800.102993305403;13915.860841391861;14032.859671403156;14125.434982600991;13000;13397.598072057854;13479.39342729599;13621.250831203983;13939.860601393857;13653.931730341284;13799.2410417428;14045.297735113;14274.357653905807;14521.128732276096;7904;8009.159038300894;8023.318017968538;8031.196880312155;8732.95204575455;8719.869201962103;8814.294856411343;9794.608215671293;13730.51943181984;13946.16323020622 07:07:07 INFO - 2015-11-27 07:07:07,445 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1458.759304714722;1598.2248609424428;1630.747234178702;1641.3188526761403;1673.1299724143446;6246.718897649605;6311.77908773193;6593.769218077368;6687.531872768908;6710.295418981003;6620.503462240327;6685.933140668604;6686.431653309474;6702.262751097375;6708.463322934166;1924.1533725160918;1941.4758015335851;1951.1610007696684;1952.5606738483868;1952.7949565295653;1955.6870900655897;1959.089023604031;1969.4387099676524;2002.7096071069686;2003.2087325506416;1918.7985261547547;1952.1410579345043;1954.8729332593336;1956.9902150489227;1958.8530860185472;1886.0381205585113;1911.4743445552444;1919.3090487424515;1922.4232730180959;1925.422373288015;1915.5306949797389;1918.5970946101336;1961.6861302191724;1972.3195497553465;1975.7727861295991;6390.6804659767295;6468.029795530661;6516.218053833523;6518.837029074263;6535.150430444012;3766.246750649881;3840.3087444260022;3840.6927445804267;3849.056981039635;3855.6722678572355;2482.379405148713;2513.5421455555734;2530.266222795387;2536;2553.8723063846733;830.1656834880966;856.648774002656;857.5669287010082;860.2429861721645;863.1497974495118;8369.288610468118;8371.414001019932;8432.45189062709;8436.029856566513;8439.873401898976;3333.1333853198344;3373.139849338403;3379.881704140343;3384.0524653097173;3393.423118069934;6948.200956889921;6999.895001574981;7006.9299307007295;7010.614416207158;7011.649417529103;3788.6400791924725;3790.7346485746284;3799.639034291738;3802.2015376770637;3816.5229346331707;3007.9097627071224;3060.7398371138256;3496.3182179474757;3503;3508.6315936826777;2931.0913616778867;2972.821630702165;2987.118799954019;2995.4907665696883;3002.8648710808066;893.2942975049638;893.4371346051946;900.6352427266968;905.3526728389234;910.2886573242262;941.9481928493999;955.0640372435053;992.8709267795285;996.4121168510613;1196.3838623109107;6269.153664255267;6354.682265886687;6379.202599675041;6379.712912918837;6402.839929001719;450.4729466524175;476.10017067741995;478.00336298817354;479.3432996794414;635.9411579719807;4864.416270047617;4935.161022626162;4949.628777841676;4973.179425394769;4982.302477653131;7358;7842.568658723825;7843.764687059397;7848.9215107848195;7855.6464959076975;7713.884291735629;7746.0704715433385;7779.3776497880035;7782.066152061789;7783.4162437817395;5915.733791979371;6112.633242005583;6137.202163718688;6190.473809726223;6232.439080482778;6213.9067913980425;6251.3123556407845;6281.968590157203;6283.465905397909;6299.622022678654;6931.584104953719;7000.22997470288;7049.9647501762165;7092.326229008236;7161.606111663908;7022.929770702228;7129.180144283474;7177.282271772781;7190.604516751419;7236.891446628199;5440.646357986719;5743.971280143573;5918.23063001807;5990.371011043778;6003.369646187088;6270.15352927349;6277.71750271248;6285.340039295808;6314.905276420765;6319.8104056878365;5430.647007944471;5685.403032681509;5755.050416681201;5795.94204057954;5903.527717782653;5583.302087239095;5792.4497172768515;5801;5811.907713223321;5824.912626310524;5888.411158884077;5993.730282137401;5995.46040856325;6000.639961602318;6001.2498437695285;5513.917291240555;5528.612997090165;5531.253280807039;5543.667379957215;5550.639208451437;5421;5439.048166570755;5443.891122177613;5449.591280654046;5463 07:07:07 INFO - 2015-11-27 07:07:07,446 DEBUG : BROWSER_OUTPUT: |4;prototype.html;279.2279347603874;279.33936240790524;285.67005109099;287.1729419272496;289.76963314165243;5292.2061690746405;5522.0888553388695;5561.2770339855815;5568.1091025435935;5628;5485.0949593317155;5541.390447050831;5558.749856256468;5559.360673522546;5572.0527510323245;4251.766152861584;4251.787410629471;4256.978715106436;4260.254455470295;4260.531341552427;4253.8723838284905;4256.87229383119;4263.488381394237;4268.78656067197;4270.0605866709275;4025.215083058805;4201.768902710365;4211.747295162285;4217.493900731916;4224.577542245766;4158.792060396968;4165.5834416558255;4168.3955826405;4179.519355274137;4186.372044193365;3587.461880717887;3589.192431702872;3589.892303230907;3597.0827439002887;3597.80212088335;5146.485351464861;5305.204219367087;5305.973470132663;5307.65500242483;5330.253764472977;4814.422269327703;4815.49437309081;4824.951750482521;4827.300041493999;4827.565519103297;5827;5827.242458480413;5833.941660583382;5839.386864379221;5842.065269556893;3924.4309575111733;3932.4494570760116;3935.9016024599327;3936.9960660031793;3938.4289278054807;5863.296404431453;6129.019356902874;6129.11127886454;6133.233345831771;6145.754169833157;4057.350823868167;4063.674906007512;4066.34938409853;4073.287174744408;4081.5918408158946;4112.9588704112575;4133.648639865585;4140.358244472111;4142.08874047715;4147.605977432139;4765.761711914391;4801.1117943180625;4802.255650374198;4808.35087263222;4815.253635686474;5670.5463562914865;5784.1902133701315;5817.040188368872;5839.532837373;5841.532677385799;1433.5054406229833;1466.65533599604;1467.5450610310838;1470.5147301390516;1470.647044709262;925.1349987761464;961.6153538584482;967.0957654592978;970.6651205334149;983.1201075037801;5097.413797413271;5111.693298402108;5113.897722045613;5117.974410128;5160.509751573594;6079.3920607939735;6087.086936959403;6090.056041313604;6093.603915745551;6103.816885493442;5103;5105.285260063594;5106.540411362921;5106.719130447861;5108.591312694975;3190.6490286068515;3278.770486066;3295.4068267711564;3299.9340013199603;3308.6856748608843;5775;5809.593328467051;5821.941780582225;5823.155642431823;5825.679587622722;6129.969350153221;6313.715882785285;6333.904991425133;6336.049592561153;6354.078658594478;5739.540836733135;5749.390170752113;5787.826365209135;5788.5369170466265;5798.159266906275;6137.478314343331;6138.877222455615;6148.354422785722;6153.292371377349;6154.846128846814;5731.914021289601;5979.133025711334;5984.222051133499;5995.670238136944;6007.128966299774;5792.160136780059;5793.391693872083;5797.507211886868;5803.216565763737;5805.8548536286935;4030.7984600770433;4076.490438695163;4089.304818180976;4095.24238015968;4102.159057393287;5962.55280853929;6098.451139397475;6129.478994285536;6138.508919286357;6170.784022559189;5877.4122587740885;5890.087036509348;5895.528357731457;5920.73356698941;5920.79277225295;5874.7956668881925;5894.557908156819;5896.9115463268945;5899.793507227227;5906.2026626406605;5735.225744524436;5787.450192231731;5788.507976822018;5791.9131213031;5796.565257605781;5760.135979603093;5949.375315591974;5954.285485741739;5960.403959604178;5960.910586341295;5769.192313076089;5777.91333129995;5788.160716696139;5788.884222315614;5819.6508209507565 07:07:07 INFO - 2015-11-27 07:07:07,448 DEBUG : BROWSER_OUTPUT: |5;yui.html;671.5936858200788;679.969401376938;680.9761658341959;728.6830228850447;764.8508540834536;10619.203559733021;10864.565417383305;10876.836847447295;10878.292910960781;10935.070519005874;10820.783584328328;11741.882581174186;11847.7630447391;11852.585159519418;11911.940440297787;600.7236671131285;610.2432983100945;756.5990025286593;773.9729109481169;774.1909704358958;754.2231501553381;772.2779201446665;778.4511919097051;779.9532028078305;780.1652232111643;786.5162924801264;798.8442253760519;800.747764454198;804.9436539442241;805.6374631415857;785.3834739729314;800.1198681450417;802.546561192927;803.7709252862965;806.6249194124701;587.0753563138032;589.7316720892027;595.8152972578514;596.9850753731148;597.4175179200245;10862.72843178919;10965.177611679077;10973.615923442641;10985.61550345742;11028.28316159447;10514.579416823319;10704.732381690443;10895.455227238606;11093.278936869077;11280.774384512264;9550.761230969281;9576.521173941344;9613.855792163124;9695.369800962915;9834.901650983471;3304.322613864152;3329.8501567429525;3344.3144155448317;3394.728421726281;3395.5585773849243;39316.41025384593;39489.21021579581;39830.40254396186;40293.59706402928;40298.19403611941;9054.773630659287;9077.228435582918;9155.633774649074;9229.215516681157;9247.76880577991;15682.137482438575;15703.450379236672;15721.292541835644;15807.13060781645;15813;6210.223722034746;6238.719257633417;6254.061890716429;6397.072424498515;6409.455196308366;3402.2685122698244;3468.4103702370658;3586.802725850051;3659.0669379308106;3668.4497325401403;2675.67891852975;2693.9461210775676;2704.8647567621933;2710.241132482908;2713.240292718042;476.5568021739815;486.936698229235;489.39315249090873;493.8765308672832;496.548141191514;564.3848205456072;574.8332983434841;585.8828234353147;607.8480379905023;617.9721912513947;7587.58268295249;7725.26609972063;7900.367970562456;8113.8377232456205;8156.265936065783;465.42752414530315;477.7730577975434;484.1914003613973;490.2694984473109;554.6782865937746;3479.739019573542;3529.347070791912;3622.800745958945;3703.5370578677666;3706.79612621303;47796.522034779904;47834.28248576274;48687.756561216964;48940.51059489431;48947.510524895006;42583.78708106501;42770.35844462336;43203.56796432058;43346.133077338905;43593.34609980853;39317.41023884644;39548.406773898416;39931.80034099869;40159;40380.79809600992;7615.885761713689;7762.5730584818375;8145.470544414594;8165.836683266182;8172.959135204286;29803.70196298096;30486.84756576203;30741.53887691731;30769.846150769103;31311.68688313088;36668.81665591762;36947.815260923526;38911.22177556376;39277.80361098176;39772.2045559093;9504.524773761146;9931.503424828585;10236;10289.639862604772;10352.896471035194;11742.647720568397;11783.116266280234;11796.351200684045;11817;11908.106891982963;9436.197923176607;10361.689149325532;10954.835677465004;11082.556697732;11463.197576169589;9872.062154095349;10712;11165.162612804235;11293.153013523854;11315.547378104784;10258.846117308098;10487.94756026215;10974.890251097706;11160.10719142483;11168.162387821108;8376.623051962555;8561.61472733716;8565.357598180286;8628.78428039304;8882.111788821325;8223.712170074019;8376.874346884924;8672.52301123419;8676.436031657922;9068.455892646462 07:07:07 INFO - 2015-11-27 07:07:07,448 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:07:07 INFO - 2015-11-27 07:07:07,448 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:07:07 INFO - 2015-11-27 07:07:07,448 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,316 07:07:07 INFO - 2015-11-27 07:07:07,448 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:07:07 INFO - 2015-11-27 07:07:07,448 DEBUG : BROWSER_OUTPUT: __startTimestamp1448636827438__endTimestamp 07:07:07 INFO - 2015-11-27 07:07:07,448 DEBUG : BROWSER_OUTPUT: 07:07:07 INFO - 2015-11-27 07:07:07,449 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:07:07 INFO - 2015-11-27 07:07:07,449 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:07:07 INFO - 2015-11-27 07:07:07,449 DEBUG : BROWSER_OUTPUT: 07:07:07 INFO - 2015-11-27 07:07:07,449 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4611.38 Median:4719.06 stddev:473.12 (10.0%) stddev-sans-first:447.93 07:07:07 INFO - 2015-11-27 07:07:07,449 DEBUG : BROWSER_OUTPUT: Values: 2615.7 2677.9 2711.3 2725.0 2728.7 4513.3 4661.8 4695.9 4702.4 4742.0 4515.2 4577.0 4622.7 4643.2 4648.4 4187.0 4288.9 4305.5 4343.9 4404.2 4365.0 4427.1 4433.9 4434.4 4439.3 4100.8 4185.3 4269.7 4273.8 4273.9 4339.3 4346.8 4367.3 4374.1 4379.4 4311.7 4315.1 4333.2 4345.7 4377.3 4270.7 4373.9 4395.3 4398.2 4659.8 4850.5 4941.8 4956.1 4962.6 5003.3 5087.9 5110.3 5120.5 5121.2 5180.2 4511.7 4654.3 4694.2 4719.1 4722.0 5079.2 5189.1 5196.3 5196.4 5226.7 4952.2 4956.8 4963.9 4967.4 5003.6 4796.9 4863.4 4911.1 5047.3 5053.7 4926.6 4953.1 4975.9 4982.6 4987.9 4950.0 4954.6 4958.6 4959.3 4988.4 4060.8 4154.2 4163.3 4166.5 4290.2 3654.5 3720.3 3723.5 3740.6 3750.4 4335.7 4337.9 4360.7 4391.6 4397.1 4852.6 4887.5 4962.2 5038.4 5060.3 4298.7 4336.4 4341.0 4349.7 4374.9 4467.6 4474.3 4492.6 4495.4 4515.1 4585.1 4607.3 4695.7 4698.8 4779.5 4970.3 4980.5 5000.3 5008.3 5064.1 4698.5 4712.0 4712.4 4739.5 4744.9 4719.1 4817.1 4857.8 4863.9 4875.4 5037.5 5041.2 5058.9 5064.0 5068.5 4895.7 4901.0 4905.5 4924.5 4935.7 4635.3 4780.6 4791.9 4903.8 4926.0 4725.7 4752.9 4773.9 4774.3 4792.0 4832.0 4868.7 4881.5 4887.0 4913.0 4662.3 4683.8 4779.1 4782.0 4796.6 07:07:07 INFO - 2015-11-27 07:07:07,449 DEBUG : BROWSER_OUTPUT: 07:07:07 INFO - 2015-11-27 07:07:07,449 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42992.97 Median:35973.23 stddev:71527.62 (198.8%) stddev-sans-first:71657.32 07:07:07 INFO - 2015-11-27 07:07:07,451 DEBUG : BROWSER_OUTPUT: Values: 561.0 564.9 567.0 577.5 592.5 32452.4 33041.2 33099.0 33116.8 33340.7 38602.0 39021.6 39078.2 39255.6 39426.4 7885.0 7949.6 8062.0 8069.6 8075.4 7841.8 7946.7 7957.8 7970.3 8007.1 7920.2 8048.5 8054.4 8057.9 8059.1 7892.1 7918.5 7985.4 7986.6 8000.1 7788.6 7913.9 7929.7 7947.6 7955.8 34952.0 35426.6 35766.6 35783.0 35934.6 2843.8 2913.6 2941.4 3158.6 3276.7 27382.2 27783.7 27802.3 27890.9 27972.6 3062.7 3103.2 3133.3 3154.8 3164.8 213758.0 214195.9 215109.0 215635.0 215681.0 51267.5 51280.7 51296.2 51642.0 51744.5 61050.4 62874.0 62909.0 63072.0 63139.0 12114.9 12173.2 12226.0 12269.7 12273.9 9245.8 9350.7 9374.9 9391.9 9427.8 19295.6 19386.3 19459.7 19484.3 19510.1 7675.2 7758.8 7823.3 7947.0 7953.7 814.2 820.6 824.3 828.2 959.5 29771.9 30871.8 30990.8 31008.2 31452.8 914.9 972.8 994.5 1045.0 1052.6 13592.3 13612.8 13892.2 13921.0 13941.4 329925.0 333923.0 334573.0 334745.0 336104.0 44924.8 45633.5 45734.0 45880.5 45948.0 1163.7 1205.5 1217.6 1221.5 1228.6 25003.5 25501.0 25530.5 26025.2 26037.7 38074.2 38295.0 38358.8 38722.4 38841.4 255370.0 256429.0 256598.0 257591.0 259073.0 28046.0 40087.2 41937.0 42290.4 42385.4 37824.4 38326.4 38903.8 38923.6 39499.0 32237.8 33002.8 33091.3 33608.8 33722.7 35563.5 36011.8 37318.6 37924.8 38214.0 33772.2 33911.5 37264.8 37928.1 38011.6 28401.7 30242.5 31867.7 33843.8 33973.7 23500.2 23780.3 23830.6 24082.3 25478.2 07:07:07 INFO - 2015-11-27 07:07:07,451 DEBUG : BROWSER_OUTPUT: 07:07:07 INFO - 2015-11-27 07:07:07,451 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26304.07 Median:4311.98 stddev:83465.00 (1935.7%) stddev-sans-first:83676.33 07:07:07 INFO - 2015-11-27 07:07:07,451 DEBUG : BROWSER_OUTPUT: Values: 315.5 317.4 318.8 319.7 324.0 14977.8 15164.8 15413.3 15892.2 16458.4 8455.1 8643.3 10309.7 14884.0 15063.0 4161.9 4205.7 4298.0 4317.7 4321.2 4274.3 4310.2 4313.7 4316.5 4336.5 4346.6 4361.7 4495.9 4648.3 4650.9 3727.9 4696.1 4696.8 4729.9 4735.1 4449.2 4571.6 4573.0 4573.0 4586.2 9364.8 9441.7 9442.4 9741.3 9885.6 1716.0 1729.3 1746.2 1785.7 1921.7 7978.7 8086.1 8195.3 8232.8 8275.3 1644.5 1715.8 1729.4 1758.8 1809.3 52227.5 52257.0 53374.7 54491.5 55933.7 9085.8 9312.0 9388.0 9451.3 9479.3 11709.8 11807.8 11886.9 11887.2 11891.6 6394.2 6507.6 6550.1 6628.4 6685.2 5858.3 5876.6 5907.3 5915.4 5943.9 3427.7 3428.7 3870.0 3898.9 3918.2 1575.8 1671.6 1674.5 1677.3 1677.5 708.8 835.8 840.6 906.8 972.3 14927.5 15201.3 15525.9 15643.8 16496.6 800.4 808.0 826.8 833.1 858.7 7693.0 8354.8 8393.3 8616.2 9090.9 503407.0 505488.0 507492.0 515635.0 521072.0 70720.3 72721.0 73353.6 73413.3 73615.0 1050.7 1055.9 1072.1 1100.7 1117.1 13462.8 14219.5 14277.4 14386.9 14496.6 32514.7 32652.0 32739.2 32931.7 33030.5 39965.0 40434.0 41655.4 41672.0 42000.4 7913.6 8183.8 8901.0 8949.4 9035.0 15715.0 16053.2 16163.0 16218.8 16387.8 13785.9 13800.1 13915.9 14032.9 14125.4 13000.0 13397.6 13479.4 13621.3 13939.9 13653.9 13799.2 14045.3 14274.4 14521.1 7904.0 8009.2 8023.3 8031.2 8733.0 8719.9 8814.3 9794.6 13730.5 13946.2 07:07:07 INFO - 2015-11-27 07:07:07,451 DEBUG : BROWSER_OUTPUT: 07:07:07 INFO - 2015-11-27 07:07:07,451 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4540.06 Median:5856.66 stddev:2339.37 (39.9%) stddev-sans-first:2334.47 07:07:07 INFO - 2015-11-27 07:07:07,451 DEBUG : BROWSER_OUTPUT: Values: 1458.8 1598.2 1630.7 1641.3 1673.1 6246.7 6311.8 6593.8 6687.5 6710.3 6620.5 6685.9 6686.4 6702.3 6708.5 1924.2 1941.5 1951.2 1952.6 1952.8 1955.7 1959.1 1969.4 2002.7 2003.2 1918.8 1952.1 1954.9 1957.0 1958.9 1886.0 1911.5 1919.3 1922.4 1925.4 1915.5 1918.6 1961.7 1972.3 1975.8 6390.7 6468.0 6516.2 6518.8 6535.2 3766.2 3840.3 3840.7 3849.1 3855.7 2482.4 2513.5 2530.3 2536.0 2553.9 830.2 856.6 857.6 860.2 863.1 8369.3 8371.4 8432.5 8436.0 8439.9 3333.1 3373.1 3379.9 3384.1 3393.4 6948.2 6999.9 7006.9 7010.6 7011.6 3788.6 3790.7 3799.6 3802.2 3816.5 3007.9 3060.7 3496.3 3503.0 3508.6 2931.1 2972.8 2987.1 2995.5 3002.9 893.3 893.4 900.6 905.4 910.3 941.9 955.1 992.9 996.4 1196.4 6269.2 6354.7 6379.2 6379.7 6402.8 450.5 476.1 478.0 479.3 635.9 4864.4 4935.2 4949.6 4973.2 4982.3 7358.0 7842.6 7843.8 7848.9 7855.6 7713.9 7746.1 7779.4 7782.1 7783.4 5915.7 6112.6 6137.2 6190.5 6232.4 6213.9 6251.3 6282.0 6283.5 6299.6 6931.6 7000.2 7050.0 7092.3 7161.6 7022.9 7129.2 7177.3 7190.6 7236.9 5440.6 5744.0 5918.2 5990.4 6003.4 6270.2 6277.7 6285.3 6314.9 6319.8 5430.6 5685.4 5755.1 5795.9 5903.5 5583.3 5792.4 5801.0 5811.9 5824.9 5888.4 5993.7 5995.5 6000.6 6001.2 5513.9 5528.6 5531.3 5543.7 5550.6 5421.0 5439.0 5443.9 5449.6 5463.0 07:07:07 INFO - 2015-11-27 07:07:07,451 DEBUG : BROWSER_OUTPUT: 07:07:07 INFO - 2015-11-27 07:07:07,452 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4827.21 Median:5560.32 stddev:1458.53 (26.2%) stddev-sans-first:1422.12 07:07:07 INFO - 2015-11-27 07:07:07,453 DEBUG : BROWSER_OUTPUT: Values: 279.2 279.3 285.7 287.2 289.8 5292.2 5522.1 5561.3 5568.1 5628.0 5485.1 5541.4 5558.7 5559.4 5572.1 4251.8 4251.8 4257.0 4260.3 4260.5 4253.9 4256.9 4263.5 4268.8 4270.1 4025.2 4201.8 4211.7 4217.5 4224.6 4158.8 4165.6 4168.4 4179.5 4186.4 3587.5 3589.2 3589.9 3597.1 3597.8 5146.5 5305.2 5306.0 5307.7 5330.3 4814.4 4815.5 4825.0 4827.3 4827.6 5827.0 5827.2 5833.9 5839.4 5842.1 3924.4 3932.4 3935.9 3937.0 3938.4 5863.3 6129.0 6129.1 6133.2 6145.8 4057.4 4063.7 4066.3 4073.3 4081.6 4113.0 4133.6 4140.4 4142.1 4147.6 4765.8 4801.1 4802.3 4808.4 4815.3 5670.5 5784.2 5817.0 5839.5 5841.5 1433.5 1466.7 1467.5 1470.5 1470.6 925.1 961.6 967.1 970.7 983.1 5097.4 5111.7 5113.9 5118.0 5160.5 6079.4 6087.1 6090.1 6093.6 6103.8 5103.0 5105.3 5106.5 5106.7 5108.6 3190.6 3278.8 3295.4 3299.9 3308.7 5775.0 5809.6 5821.9 5823.2 5825.7 6130.0 6313.7 6333.9 6336.0 6354.1 5739.5 5749.4 5787.8 5788.5 5798.2 6137.5 6138.9 6148.4 6153.3 6154.8 5731.9 5979.1 5984.2 5995.7 6007.1 5792.2 5793.4 5797.5 5803.2 5805.9 4030.8 4076.5 4089.3 4095.2 4102.2 5962.6 6098.5 6129.5 6138.5 6170.8 5877.4 5890.1 5895.5 5920.7 5920.8 5874.8 5894.6 5896.9 5899.8 5906.2 5735.2 5787.5 5788.5 5791.9 5796.6 5760.1 5949.4 5954.3 5960.4 5960.9 5769.2 5777.9 5788.2 5788.9 5819.7 07:07:07 INFO - 2015-11-27 07:07:07,453 DEBUG : BROWSER_OUTPUT: 07:07:07 INFO - 2015-11-27 07:07:07,453 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11995.35 Median:22029.39 stddev:13452.92 (61.1%) stddev-sans-first:13463.79 07:07:07 INFO - 2015-11-27 07:07:07,453 DEBUG : BROWSER_OUTPUT: Values: 671.6 680.0 681.0 728.7 764.9 10619.2 10864.6 10876.8 10878.3 10935.1 10820.8 11741.9 11847.8 11852.6 11911.9 600.7 610.2 756.6 774.0 774.2 754.2 772.3 778.5 780.0 780.2 786.5 798.8 800.7 804.9 805.6 785.4 800.1 802.5 803.8 806.6 587.1 589.7 595.8 597.0 597.4 10862.7 10965.2 10973.6 10985.6 11028.3 10514.6 10704.7 10895.5 11093.3 11280.8 9550.8 9576.5 9613.9 9695.4 9834.9 3304.3 3329.9 3344.3 3394.7 3395.6 39316.4 39489.2 39830.4 40293.6 40298.2 9054.8 9077.2 9155.6 9229.2 9247.8 15682.1 15703.5 15721.3 15807.1 15813.0 6210.2 6238.7 6254.1 6397.1 6409.5 3402.3 3468.4 3586.8 3659.1 3668.4 2675.7 2693.9 2704.9 2710.2 2713.2 476.6 486.9 489.4 493.9 496.5 564.4 574.8 585.9 607.8 618.0 7587.6 7725.3 7900.4 8113.8 8156.3 465.4 477.8 484.2 490.3 554.7 3479.7 3529.3 3622.8 3703.5 3706.8 47796.5 47834.3 48687.8 48940.5 48947.5 42583.8 42770.4 43203.6 43346.1 43593.3 39317.4 39548.4 39931.8 40159.0 40380.8 7615.9 7762.6 8145.5 8165.8 8173.0 29803.7 30486.8 30741.5 30769.8 31311.7 36668.8 36947.8 38911.2 39277.8 39772.2 9504.5 9931.5 10236.0 10289.6 10352.9 11742.6 11783.1 11796.4 11817.0 11908.1 9436.2 10361.7 10954.8 11082.6 11463.2 9872.1 10712.0 11165.2 11293.2 11315.5 10258.8 10487.9 10974.9 11160.1 11168.2 8376.6 8561.6 8565.4 8628.8 8882.1 8223.7 8376.9 8672.5 8676.4 9068.5 07:07:07 INFO - 2015-11-27 07:07:07,453 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:07:07 INFO - 2015-11-27 07:07:07,453 DEBUG : BROWSER_OUTPUT: 07:07:08 INFO - 2015-11-27 07:07:08,189 INFO : Browser exited with error code: 0 07:07:08 INFO - 2015-11-27 07:07:08,208 INFO : Completed test dromaeo_css (00:18:35) 07:07:08 INFO - 2015-11-27 07:07:08,208 INFO : Starting test kraken 07:07:08 INFO - 2015-11-27 07:07:08,208 DEBUG : operating with platform_type : linux_ 07:07:08 INFO - 2015-11-27 07:07:08,208 INFO : Initialising browser for kraken test... 07:07:08 INFO - 2015-11-27 07:07:08,214 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxGUV15/profile http://localhost:47250/getInfo.html 07:07:13 INFO - 2015-11-27 07:07:13,265 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:07:13 INFO - 2015-11-27 07:07:13,266 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:07:13 INFO - 2015-11-27 07:07:13,266 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:07:13 INFO - 2015-11-27 07:07:13,266 DEBUG : BROWSER_OUTPUT: __metrics 07:07:14 INFO - 2015-11-27 07:07:14,401 INFO : Browser initialized. 07:07:14 INFO - 2015-11-27 07:07:14,402 INFO : Running cycle 1/1 for kraken test... 07:07:14 INFO - 2015-11-27 07:07:14,402 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxGUV15/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:07:26 INFO - 2015-11-27 07:07:26,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 139276288 07:07:26 INFO - 2015-11-27 07:07:26,306 DEBUG : BROWSER_OUTPUT: 07:07:28 INFO - 2015-11-27 07:07:28,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47250/tests/kraken/driver.html?testName=audio-beat-detection) 07:07:29 INFO - 2015-11-27 07:07:29,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 141893632 07:07:29 INFO - 2015-11-27 07:07:29,468 DEBUG : BROWSER_OUTPUT: 07:07:32 INFO - 2015-11-27 07:07:32,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47250/tests/kraken/driver.html?testName=audio-dft) 07:07:32 INFO - 2015-11-27 07:07:32,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 141479936 07:07:32 INFO - 2015-11-27 07:07:32,871 DEBUG : BROWSER_OUTPUT: 07:07:35 INFO - 2015-11-27 07:07:35,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47250/tests/kraken/driver.html?testName=audio-fft) 07:07:36 INFO - 2015-11-27 07:07:36,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 135438336 07:07:36 INFO - 2015-11-27 07:07:36,360 DEBUG : BROWSER_OUTPUT: 07:07:38 INFO - 2015-11-27 07:07:38,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47250/tests/kraken/driver.html?testName=audio-oscillator) 07:07:39 INFO - 2015-11-27 07:07:39,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 135909376 07:07:39 INFO - 2015-11-27 07:07:39,065 DEBUG : BROWSER_OUTPUT: 07:07:41 INFO - 2015-11-27 07:07:41,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:07:41 INFO - 2015-11-27 07:07:41,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 136085504 07:07:41 INFO - 2015-11-27 07:07:41,935 DEBUG : BROWSER_OUTPUT: 07:07:45 INFO - 2015-11-27 07:07:45,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47250/tests/kraken/driver.html?testName=imaging-darkroom) 07:07:45 INFO - 2015-11-27 07:07:45,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 138158080 07:07:45 INFO - 2015-11-27 07:07:45,636 DEBUG : BROWSER_OUTPUT: 07:07:49 INFO - 2015-11-27 07:07:49,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47250/tests/kraken/driver.html?testName=imaging-desaturate) 07:07:49 INFO - 2015-11-27 07:07:49,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 135389184 07:07:49 INFO - 2015-11-27 07:07:49,707 DEBUG : BROWSER_OUTPUT: 07:07:52 INFO - 2015-11-27 07:07:52,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47250/tests/kraken/driver.html?testName=json-parse-financial) 07:07:53 INFO - 2015-11-27 07:07:53,241 DEBUG : BROWSER_OUTPUT: RSS: Main: 135774208 07:07:53 INFO - 2015-11-27 07:07:53,241 DEBUG : BROWSER_OUTPUT: 07:07:55 INFO - 2015-11-27 07:07:55,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:07:55 INFO - 2015-11-27 07:07:55,599 DEBUG : BROWSER_OUTPUT: RSS: Main: 138072064 07:07:55 INFO - 2015-11-27 07:07:55,599 DEBUG : BROWSER_OUTPUT: 07:07:57 INFO - 2015-11-27 07:07:57,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47250/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:07:58 INFO - 2015-11-27 07:07:58,103 DEBUG : BROWSER_OUTPUT: RSS: Main: 137773056 07:07:58 INFO - 2015-11-27 07:07:58,104 DEBUG : BROWSER_OUTPUT: 07:08:00 INFO - 2015-11-27 07:08:00,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:08:00 INFO - 2015-11-27 07:08:00,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 136921088 07:08:00 INFO - 2015-11-27 07:08:00,896 DEBUG : BROWSER_OUTPUT: 07:08:03 INFO - 2015-11-27 07:08:03,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:08:04 INFO - 2015-11-27 07:08:04,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 137392128 07:08:04 INFO - 2015-11-27 07:08:04,096 DEBUG : BROWSER_OUTPUT: 07:08:06 INFO - 2015-11-27 07:08:06,696 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:08:07 INFO - 2015-11-27 07:08:07,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 138674176 07:08:07 INFO - 2015-11-27 07:08:07,298 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47250/tests/kraken/driver.html?testName=ai-astar) 07:08:09 INFO - 2015-11-27 07:08:09,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 139673600 07:08:09 INFO - 2015-11-27 07:08:09,303 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,303 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:08:09 INFO - 2015-11-27 07:08:09,304 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:08:09 INFO - 2015-11-27 07:08:09,304 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;115;114;114;125;113;112;113;112 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;131;160;173;137;167;163;137;173;134 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;163;164;162;161;169;169;168;165;162 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |3;audio-fft;76;73;76;75;132;73;72;80;72;94 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;135;94;94;95;131;95;94;132 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;112;111;111;109;111 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;149;149;147;151;148;149;148;147 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;97;97;96;95;95;96;97;97 07:08:09 INFO - 2015-11-27 07:08:09,305 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;73;74;75;75;75;74;75;74;78 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;71;68;68;69;69;69;70;68;69 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;82;85;82;83;96;85;95;99 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;138;128;119;135;130;127;130;126;121 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;149;149;148;152;142;152;152;147;139 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;73;71;70;70;71;70;70;69;74;72 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,784 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: __startTimestamp1448636889303__endTimestamp 07:08:09 INFO - 2015-11-27 07:08:09,306 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,309 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:4.48 (3.9%) stddev-sans-first:4.76 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 115.0 114.0 114.0 125.0 113.0 112.0 113.0 112.0 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:153.10 Median:161.50 stddev:16.70 (10.3%) stddev-sans-first:17.68 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: Values: 156.0 131.0 160.0 173.0 137.0 167.0 163.0 137.0 173.0 134.0 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:2.98 (1.8%) stddev-sans-first:3.15 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: Values: 164.0 163.0 164.0 162.0 161.0 169.0 169.0 168.0 165.0 162.0 07:08:09 INFO - 2015-11-27 07:08:09,310 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,311 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.30 Median:75.50 stddev:18.65 (24.7%) stddev-sans-first:19.64 07:08:09 INFO - 2015-11-27 07:08:09,311 DEBUG : BROWSER_OUTPUT: Values: 76.0 73.0 76.0 75.0 132.0 73.0 72.0 80.0 72.0 94.0 07:08:09 INFO - 2015-11-27 07:08:09,311 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,311 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.00 stddev:18.44 (19.6%) stddev-sans-first:19.20 07:08:09 INFO - 2015-11-27 07:08:09,311 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 135.0 94.0 94.0 95.0 131.0 95.0 94.0 132.0 07:08:09 INFO - 2015-11-27 07:08:09,311 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,311 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:111.00 stddev:0.85 (0.8%) stddev-sans-first:0.88 07:08:09 INFO - 2015-11-27 07:08:09,312 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 112.0 111.0 111.0 109.0 111.0 07:08:09 INFO - 2015-11-27 07:08:09,312 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,312 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:1.25 (0.8%) stddev-sans-first:1.32 07:08:09 INFO - 2015-11-27 07:08:09,312 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 149.0 149.0 147.0 151.0 148.0 149.0 148.0 147.0 07:08:09 INFO - 2015-11-27 07:08:09,312 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,312 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:97.00 stddev:0.84 (0.9%) stddev-sans-first:0.87 07:08:09 INFO - 2015-11-27 07:08:09,312 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 97.0 97.0 96.0 95.0 95.0 96.0 97.0 97.0 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.80 Median:75.00 stddev:1.32 (1.8%) stddev-sans-first:1.39 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 74.0 75.0 75.0 75.0 74.0 75.0 74.0 78.0 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.00 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 68.0 68.0 69.0 69.0 69.0 70.0 68.0 69.0 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:85.00 stddev:6.86 (8.1%) stddev-sans-first:6.93 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 85.0 82.0 83.0 96.0 85.0 95.0 99.0 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,313 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:129.00 stddev:6.02 (4.7%) stddev-sans-first:6.04 07:08:09 INFO - 2015-11-27 07:08:09,314 DEBUG : BROWSER_OUTPUT: Values: 122.0 138.0 128.0 119.0 135.0 130.0 127.0 130.0 126.0 121.0 07:08:09 INFO - 2015-11-27 07:08:09,314 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,314 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:149.00 stddev:5.70 (3.8%) stddev-sans-first:4.58 07:08:09 INFO - 2015-11-27 07:08:09,314 DEBUG : BROWSER_OUTPUT: Values: 136.0 149.0 149.0 148.0 152.0 142.0 152.0 152.0 147.0 139.0 07:08:09 INFO - 2015-11-27 07:08:09,314 DEBUG : BROWSER_OUTPUT: 07:08:09 INFO - 2015-11-27 07:08:09,314 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.56 (2.2%) stddev-sans-first:1.48 07:08:09 INFO - 2015-11-27 07:08:09,314 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 70.0 70.0 71.0 70.0 70.0 69.0 74.0 72.0 07:08:09 INFO - 2015-11-27 07:08:09,314 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:08:09 INFO - 2015-11-27 07:08:09,314 DEBUG : BROWSER_OUTPUT: 07:08:10 INFO - 2015-11-27 07:08:10,273 INFO : Browser exited with error code: 0 07:08:10 INFO - 2015-11-27 07:08:10,326 INFO : Completed test kraken (00:01:02) 07:08:10 INFO - 2015-11-27 07:08:10,327 INFO : Starting test v8_7 07:08:10 INFO - 2015-11-27 07:08:10,327 DEBUG : operating with platform_type : linux_ 07:08:10 INFO - 2015-11-27 07:08:10,327 INFO : Initialising browser for v8_7 test... 07:08:10 INFO - 2015-11-27 07:08:10,333 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_1FiCk/profile http://localhost:47250/getInfo.html 07:08:15 INFO - 2015-11-27 07:08:15,783 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:08:15 INFO - 2015-11-27 07:08:15,784 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:08:15 INFO - 2015-11-27 07:08:15,784 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:08:15 INFO - 2015-11-27 07:08:15,784 DEBUG : BROWSER_OUTPUT: __metrics 07:08:16 INFO - 2015-11-27 07:08:16,993 INFO : Browser initialized. 07:08:16 INFO - 2015-11-27 07:08:16,994 INFO : Running cycle 1/1 for v8_7 test... 07:08:16 INFO - 2015-11-27 07:08:16,994 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_1FiCk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:08:28 INFO - 2015-11-27 07:08:28,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 138633216 07:08:28 INFO - 2015-11-27 07:08:28,892 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:47250/tests/v8_7/run.html (next: http://localhost:47250/tests/v8_7/run.html) 07:08:50 INFO - 2015-11-27 07:08:50,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 137179136 07:08:50 INFO - 2015-11-27 07:08:50,550 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,550 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:08:50 INFO - 2015-11-27 07:08:50,550 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:08:50 INFO - 2015-11-27 07:08:50,551 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:08:50 INFO - 2015-11-27 07:08:50,551 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:08:50 INFO - 2015-11-27 07:08:50,551 DEBUG : BROWSER_OUTPUT: |0;Richards;168.74789065136684 07:08:50 INFO - 2015-11-27 07:08:50,551 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.58729575913347 07:08:50 INFO - 2015-11-27 07:08:50,551 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.9321845469705 07:08:50 INFO - 2015-11-27 07:08:50,551 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5251.308900523561 07:08:50 INFO - 2015-11-27 07:08:50,552 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1075.268817204301 07:08:50 INFO - 2015-11-27 07:08:50,552 DEBUG : BROWSER_OUTPUT: |5;Earley;746.2686567164179 07:08:50 INFO - 2015-11-27 07:08:50,552 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 07:08:50 INFO - 2015-11-27 07:08:50,552 DEBUG : BROWSER_OUTPUT: |7;RegExp;25820.51282051282 07:08:50 INFO - 2015-11-27 07:08:50,552 DEBUG : BROWSER_OUTPUT: |8;Splay;594.5465323058684 07:08:50 INFO - 2015-11-27 07:08:50,552 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 07:08:50 INFO - 2015-11-27 07:08:50,552 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:08:50 INFO - 2015-11-27 07:08:50,553 DEBUG : BROWSER_OUTPUT: __startTimestamp1448636930550__endTimestamp 07:08:50 INFO - 2015-11-27 07:08:50,553 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,553 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:08:50 INFO - 2015-11-27 07:08:50,553 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:08:50 INFO - 2015-11-27 07:08:50,554 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,554 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.75 Median:168.75 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,554 DEBUG : BROWSER_OUTPUT: Values: 168.7 07:08:50 INFO - 2015-11-27 07:08:50,554 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,555 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.59 Median:183.59 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,555 DEBUG : BROWSER_OUTPUT: Values: 183.6 07:08:50 INFO - 2015-11-27 07:08:50,555 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,556 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,556 DEBUG : BROWSER_OUTPUT: Values: 277.9 07:08:50 INFO - 2015-11-27 07:08:50,556 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,556 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,557 DEBUG : BROWSER_OUTPUT: Values: 5251.3 07:08:50 INFO - 2015-11-27 07:08:50,557 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,557 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1075.27 Median:1075.27 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,557 DEBUG : BROWSER_OUTPUT: Values: 1075.3 07:08:50 INFO - 2015-11-27 07:08:50,558 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,558 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:746.27 Median:746.27 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,558 DEBUG : BROWSER_OUTPUT: Values: 746.3 07:08:50 INFO - 2015-11-27 07:08:50,558 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,559 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,559 DEBUG : BROWSER_OUTPUT: Values: 12132.5 07:08:50 INFO - 2015-11-27 07:08:50,559 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,559 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25820.51 Median:25820.51 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,559 DEBUG : BROWSER_OUTPUT: Values: 25820.5 07:08:50 INFO - 2015-11-27 07:08:50,560 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,560 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.55 Median:594.55 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,560 DEBUG : BROWSER_OUTPUT: Values: 594.5 07:08:50 INFO - 2015-11-27 07:08:50,560 DEBUG : BROWSER_OUTPUT: 07:08:50 INFO - 2015-11-27 07:08:50,561 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 07:08:50 INFO - 2015-11-27 07:08:50,561 DEBUG : BROWSER_OUTPUT: Values: 4835.7 07:08:50 INFO - 2015-11-27 07:08:50,561 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:08:50 INFO - 2015-11-27 07:08:50,561 DEBUG : BROWSER_OUTPUT: 07:08:51 INFO - 2015-11-27 07:08:51,497 INFO : Browser exited with error code: 0 07:08:51 INFO - 2015-11-27 07:08:51,512 INFO : Completed test v8_7 (00:00:41) 07:08:51 INFO - 2015-11-27 07:08:51,549 INFO : Completed test suite (00:20:18) 07:08:51 INFO - 2015-11-27 07:08:51,549 DEBUG : Working with test: dromaeo_css 07:08:51 INFO - 2015-11-27 07:08:51,549 DEBUG : Generating results file: dromaeo_css 07:08:51 INFO - 2015-11-27 07:08:51,551 DEBUG : Working with test: kraken 07:08:51 INFO - 2015-11-27 07:08:51,551 DEBUG : Generating results file: kraken 07:08:51 INFO - 2015-11-27 07:08:51,551 INFO : javascript benchmark 07:08:51 INFO - 2015-11-27 07:08:51,551 DEBUG : Working with test: v8_7 07:08:51 INFO - 2015-11-27 07:08:51,551 DEBUG : Generating results file: v8_7 07:08:51 INFO - 2015-11-27 07:08:51,552 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:08:51 INFO - 2015-11-27 07:08:51,605 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 07:08:51 INFO - 2015-11-27 07:08:51,606 DEBUG : process_Request line: dromaeo_css 6150.43 graph.html#tests=[[72,132,43]] 07:08:51 INFO - 2015-11-27 07:08:51,606 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:08:51 INFO - 2015-11-27 07:08:51,633 DEBUG : process_Request line: kraken 1551.50 graph.html#tests=[[232,132,43]] 07:08:51 INFO - 2015-11-27 07:08:51,634 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:08:51 INFO - 2015-11-27 07:08:51,671 DEBUG : process_Request line: v8_7 21284.11 graph.html#tests=[[230,132,43]] 07:08:51 INFO - 2015-11-27 07:08:51,672 INFO : javascript benchmark 07:08:51 INFO - 2015-11-27 07:08:51,676 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2615.712271650118, 2677.919662410126, 2711.295063283547, 2725.01899316246, 2728.658917635295, 4513.323001549769, 4661.79021944012, 4695.929561056587, 4702.412198475191, 4742.0, 4515.164694531514, 4576.977115114428, 4622.676412651116, 4643.16423043852, 4648.395708557883, 4186.958130418688, 4288.892777680552, 4305.461817272841, 4343.891402714926, 4404.207242696313, 4365.01787097902, 4427.11457708458, 4433.88915277119, 4434.423524941753, 4439.289713645818, 4100.835966561334, 4185.2885009548145, 4269.701120921537, 4273.786310684484, 4273.893152671177, 4339.349097635349, 4346.804393802255, 4367.3448982652535, 4374.125174964988, 4379.430674012358, 4311.741295522279, 4315.07225946423, 4333.2200203963275, 4345.674074444398, 4377.277749171383, 4270.658347332206, 4373.912521749579, 4395.274779661352, 4398.230309695822, 4659.790309436084, 4850.514948505156, 4941.802327906879, 4956.058348913695, 4962.62780291476, 5003.324551185579, 5087.872803179913, 5110.310108135392, 5120.462351453119, 5121.180611102243, 5180.248863914749, 4511.70673906195, 4654.2785868190485, 4694.155052090622, 4719.056188762262, 4722.008378240539, 5079.238114282887, 5189.065968125774, 5196.298499702568, 5196.350456192976, 5226.660267082628, 4952.182889823139, 4956.752162391866, 4963.875903102451, 4967.354243948336, 5003.574696150795, 4796.928046079312, 4863.392075990501, 4911.140550403665, 5047.268146118792, 5053.747312634354, 4926.605871530269, 4953.0589188054155, 4975.900481990412, 4982.551570358685, 4987.925181122286, 4950.0, 4954.603631709455, 4958.603311735053, 4959.330490383824, 4988.376452943382, 4060.796960151981, 4154.231467178582, 4163.250614889349, 4166.520850102216, 4290.227759003409, 3654.506641603403, 3720.330340538675, 3723.5345581802276, 3740.6446387593137, 3750.4186851038135, 4335.739855608674, 4337.9132417351475, 4360.672949528798, 4391.604755572014, 4397.098594788061, 4852.587530059985, 4887.511248875155, 4962.181240095416, 5038.445770965191, 5060.316857224301, 4298.742075475481, 4336.392904993303, 4340.978295108567, 4349.652027837766, 4374.912501749947, 4467.597916187558, 4474.284114541722, 4492.618127459137, 4495.415595972503, 4515.0518391137575, 4585.105904348687, 4607.285870690049, 4695.671303008757, 4698.8355407560575, 4779.450363208275, 4970.304157417892, 4980.526849949249, 5000.349954506037, 5008.2738002988635, 5064.139096353702, 4698.530146985411, 4711.952880471152, 4712.387389639325, 4739.52604739537, 4744.88137796544, 4719.0561887621925, 4817.132916075, 4857.805687772449, 4863.90272194547, 4875.390576177978, 5037.471065538066, 5041.168207245763, 5058.898822023612, 5064.037832811754, 5068.543831055075, 4895.73073480962, 4900.975495122644, 4905.5094490550655, 4924.482929292372, 4935.679180853233, 4635.258358662598, 4780.5697487224925, 4791.880202994814, 4903.803847846046, 4926.039422312758, 4725.740084295397, 4752.881177970578, 4773.904521909473, 4774.283857421415, 4791.952080479151, 4831.975840120777, 4868.6611181925255, 4881.463039065629, 4887.022595480847, 4913.041956818386, 4662.32396302541, 4683.812647494062, 4779.139754844023, 4782.0, 4796.592289655418], "unit": "ms", "name": "dojo.html", "value": 4582.5523968448915}, {"lowerIsBetter": false, "replicates": [560.9663420194788, 564.9180868774026, 567.0332083797126, 577.4975771079162, 592.5111782779205, 32452.350952980956, 33041.17397065074, 33099.0, 33116.834415827914, 33340.66659333406, 38602.0, 39021.609783902226, 39078.21843563127, 39255.60744392555, 39426.40860387089, 7884.999999999985, 7949.6025198739835, 8061.95969020157, 8069.556174410405, 8075.434719569633, 7841.764747057598, 7946.682132714714, 7957.801054973614, 7970.322522585587, 8007.079185893609, 7920.16838231986, 8048.476849004796, 8054.355651547862, 8057.879131813028, 8059.113497515298, 7892.131865494791, 7918.52488850665, 7985.361171106327, 7986.560739159344, 8000.079990801074, 7788.649510771972, 7913.920860791433, 7929.72245971394, 7947.602619868983, 7955.761327160194, 34952.0, 35426.645733542595, 35766.642333576594, 35783.0, 35934.64065359339, 2843.758280546156, 2913.6357955255594, 2941.3970136122043, 3158.6051743532057, 3276.7214786742916, 27382.178534643994, 27783.72216277852, 27802.3049423764, 27890.860545697346, 27972.580411293846, 3062.72330289798, 3103.20868178613, 3133.3263348380206, 3154.763392745553, 3164.810111393324, 213758.0, 214195.92902035546, 215109.0, 215635.0, 215681.0, 51267.48732512627, 51280.743596281776, 51296.23055654168, 51642.0, 51744.48255517472, 61050.38949610447, 62874.0, 62909.0, 63072.0, 63139.0, 12114.878851211375, 12173.208741431956, 12226.0, 12269.69325766863, 12273.938630306791, 9245.768855778524, 9350.672726454677, 9374.85937710935, 9391.906080939103, 9427.76430589227, 19295.614087718448, 19386.321478748458, 19459.708104378446, 19484.297983383396, 19510.122044508033, 7675.2324767522805, 7758.806029849186, 7823.295903368724, 7946.960265198637, 7953.721619743281, 814.242754238552, 820.5938060659893, 824.2540500846624, 828.1552816127637, 959.4770849886828, 29771.85114074459, 30871.84564077165, 30990.845045775077, 31008.22479438032, 31452.842735786173, 914.9313801464916, 972.7519482531909, 994.4928086675703, 1045.0281238448165, 1052.5737076484036, 13592.320383980761, 13612.795808062887, 13892.16647001183, 13921.0, 13941.442342306396, 329925.0, 333923.0, 334573.0, 334745.0, 336104.0, 44924.77537612291, 45633.54366456359, 45734.0, 45880.541194587626, 45948.0, 1163.6799880033059, 1205.493692649072, 1217.6407959651747, 1221.4625564751482, 1228.5822820240983, 25003.49993000166, 25501.0, 25530.489390212464, 26025.21924342273, 26037.73962260429, 38074.238515228986, 38295.0, 38358.80820595879, 38722.41916371313, 38841.41737873878, 255370.0, 256429.0, 256598.0, 257591.0, 259073.0, 28046.0, 40087.198256034135, 41937.0, 42290.36564451474, 42385.36421953735, 37824.43263350997, 38326.42510362291, 38903.80548097241, 38923.610763892, 39499.0, 32237.838810805795, 33002.83498582492, 33091.33817323592, 33608.83195584006, 33722.66277337195, 35563.466548001285, 36011.819940900124, 37318.62681373151, 37924.81037594794, 38214.0, 33772.155696107795, 33911.491327629614, 37264.813675931444, 37928.05179870525, 38011.61988380191, 28401.715982840735, 30242.54636180503, 31867.681323186473, 33843.830780845936, 33973.66026339804, 23500.177493787636, 23780.286591402284, 23830.642540362256, 24082.277531674077, 25478.23565293044], "unit": "ms", "name": "ext.html", "value": 17070.018918237405}, {"lowerIsBetter": false, "replicates": [315.51725859435066, 317.4127863452613, 318.8405797101449, 319.70107949067636, 323.9902802915913, 14977.775333370008, 15164.848351516468, 15413.306401211945, 15892.205389730496, 16458.423955161572, 8455.069942306342, 8643.265322447583, 10309.690709278715, 14884.0, 15063.0, 4161.854335098272, 4205.663546916247, 4297.9570204298025, 4317.654587632997, 4321.157374312011, 4274.29474136767, 4310.245707001278, 4313.719608225455, 4316.54676258993, 4336.479622445311, 4346.56534346566, 4361.716488428257, 4495.887602809939, 4648.279516674921, 4650.883727906812, 3727.9440808387894, 4696.131215725101, 4696.812127514895, 4729.905401891943, 4735.147673418784, 4449.221386257392, 4571.565701258375, 4572.977135114336, 4573.039661671053, 4586.220342541743, 9364.812703745954, 9441.716748497556, 9442.38624489406, 9741.269404794597, 9885.555150018266, 1715.9605121147006, 1729.3082766893217, 1746.240385432341, 1785.6785778559854, 1921.702136168896, 7978.680852765882, 8086.110527841933, 8195.262426381594, 8232.794180145544, 8275.337972962148, 1644.4902080355128, 1715.8284171582866, 1729.44657709533, 1758.832910873465, 1809.2672467650623, 52227.47772522264, 52257.0, 53374.73312633451, 54491.45508544904, 55933.72033139849, 9085.81828363429, 9312.0, 9388.0, 9451.338406311492, 9479.336446448682, 11709.76580468403, 11807.822882656767, 11886.940565297118, 11887.16789824704, 11891.643250702493, 6394.23269207698, 6507.609543427409, 6550.050242714779, 6628.403443689995, 6685.231198412245, 5858.2677165354335, 5876.647401155944, 5907.261592300963, 5915.40845915405, 5943.851403714855, 3427.7429192810637, 3428.708559772397, 3869.993801611601, 3898.922021559553, 3918.2359439909515, 1575.8030246219223, 1671.5821044738816, 1674.4641714651195, 1677.2536221381367, 1677.5386768638723, 708.840510885057, 835.8370117827087, 840.630122746002, 906.8347173881531, 972.3485264872552, 14927.477538286324, 15201.315940782692, 15525.922370388076, 15643.765343519857, 16496.587585310222, 800.4116974024088, 807.9798005049921, 826.8222332198607, 833.1168960901342, 858.6737039924789, 7693.0, 8354.791130221793, 8393.286570641441, 8616.224539791448, 9090.90909090914, 503407.0, 505488.0, 507492.0, 515635.0, 521072.0, 70720.2927970724, 72721.0, 73353.6332318335, 73413.26586734172, 73615.0, 1050.6952983634812, 1055.9366438013744, 1072.1262171330497, 1100.6808025672465, 1117.1398023521842, 13462.798058028942, 14219.50231741884, 14277.42890284377, 14386.856131438552, 14496.565103046925, 32514.674853251163, 32652.020439386855, 32739.181520462178, 32931.67068329382, 33030.50454243236, 39965.0, 40434.0, 41655.37516937188, 41672.0, 42000.36999445072, 7913.643886025257, 8183.754487365389, 8901.0, 8949.373543851867, 9034.954825225832, 15715.0, 16053.19734013318, 16163.0, 16218.837811621734, 16387.83612163863, 13785.862141378459, 13800.102993305403, 13915.860841391861, 14032.859671403156, 14125.434982600991, 13000.0, 13397.598072057854, 13479.39342729599, 13621.250831203983, 13939.860601393857, 13653.931730341284, 13799.2410417428, 14045.297735113, 14274.357653905807, 14521.128732276096, 7904.0, 8009.159038300894, 8023.318017968538, 8031.196880312155, 8732.95204575455, 8719.869201962103, 8814.294856411343, 9794.608215671293, 13730.51943181984, 13946.16323020622], "unit": "ms", "name": "jquery.html", "value": 7685.580867855927}, {"lowerIsBetter": false, "replicates": [1458.759304714722, 1598.2248609424428, 1630.747234178702, 1641.3188526761403, 1673.1299724143446, 6246.718897649605, 6311.77908773193, 6593.769218077368, 6687.531872768908, 6710.295418981003, 6620.503462240327, 6685.933140668604, 6686.431653309474, 6702.262751097375, 6708.463322934166, 1924.1533725160918, 1941.4758015335851, 1951.1610007696684, 1952.5606738483868, 1952.7949565295653, 1955.6870900655897, 1959.089023604031, 1969.4387099676524, 2002.7096071069686, 2003.2087325506416, 1918.7985261547547, 1952.1410579345043, 1954.8729332593336, 1956.9902150489227, 1958.8530860185472, 1886.0381205585113, 1911.4743445552444, 1919.3090487424515, 1922.4232730180959, 1925.422373288015, 1915.5306949797389, 1918.5970946101336, 1961.6861302191724, 1972.3195497553465, 1975.7727861295991, 6390.6804659767295, 6468.029795530661, 6516.218053833523, 6518.837029074263, 6535.150430444012, 3766.246750649881, 3840.3087444260022, 3840.6927445804267, 3849.056981039635, 3855.6722678572355, 2482.379405148713, 2513.5421455555734, 2530.266222795387, 2536.0, 2553.8723063846733, 830.1656834880966, 856.648774002656, 857.5669287010082, 860.2429861721645, 863.1497974495118, 8369.288610468118, 8371.414001019932, 8432.45189062709, 8436.029856566513, 8439.873401898976, 3333.1333853198344, 3373.139849338403, 3379.881704140343, 3384.0524653097173, 3393.423118069934, 6948.200956889921, 6999.895001574981, 7006.9299307007295, 7010.614416207158, 7011.649417529103, 3788.6400791924725, 3790.7346485746284, 3799.639034291738, 3802.2015376770637, 3816.5229346331707, 3007.9097627071224, 3060.7398371138256, 3496.3182179474757, 3503.0, 3508.6315936826777, 2931.0913616778867, 2972.821630702165, 2987.118799954019, 2995.4907665696883, 3002.8648710808066, 893.2942975049638, 893.4371346051946, 900.6352427266968, 905.3526728389234, 910.2886573242262, 941.9481928493999, 955.0640372435053, 992.8709267795285, 996.4121168510613, 1196.3838623109107, 6269.153664255267, 6354.682265886687, 6379.202599675041, 6379.712912918837, 6402.839929001719, 450.4729466524175, 476.10017067741995, 478.00336298817354, 479.3432996794414, 635.9411579719807, 4864.416270047617, 4935.161022626162, 4949.628777841676, 4973.179425394769, 4982.302477653131, 7358.0, 7842.568658723825, 7843.764687059397, 7848.9215107848195, 7855.6464959076975, 7713.884291735629, 7746.0704715433385, 7779.3776497880035, 7782.066152061789, 7783.4162437817395, 5915.733791979371, 6112.633242005583, 6137.202163718688, 6190.473809726223, 6232.439080482778, 6213.9067913980425, 6251.3123556407845, 6281.968590157203, 6283.465905397909, 6299.622022678654, 6931.584104953719, 7000.22997470288, 7049.9647501762165, 7092.326229008236, 7161.606111663908, 7022.929770702228, 7129.180144283474, 7177.282271772781, 7190.604516751419, 7236.891446628199, 5440.646357986719, 5743.971280143573, 5918.23063001807, 5990.371011043778, 6003.369646187088, 6270.15352927349, 6277.71750271248, 6285.340039295808, 6314.905276420765, 6319.8104056878365, 5430.647007944471, 5685.403032681509, 5755.050416681201, 5795.94204057954, 5903.527717782653, 5583.302087239095, 5792.4497172768515, 5801.0, 5811.907713223321, 5824.912626310524, 5888.411158884077, 5993.730282137401, 5995.46040856325, 6000.639961602318, 6001.2498437695285, 5513.917291240555, 5528.612997090165, 5531.253280807039, 5543.667379957215, 5550.639208451437, 5421.0, 5439.048166570755, 5443.891122177613, 5449.591280654046, 5463.0], "unit": "ms", "name": "mootools.html", "value": 3699.5805263836833}, {"lowerIsBetter": false, "replicates": [279.2279347603874, 279.33936240790524, 285.67005109099, 287.1729419272496, 289.76963314165243, 5292.2061690746405, 5522.0888553388695, 5561.2770339855815, 5568.1091025435935, 5628.0, 5485.0949593317155, 5541.390447050831, 5558.749856256468, 5559.360673522546, 5572.0527510323245, 4251.766152861584, 4251.787410629471, 4256.978715106436, 4260.254455470295, 4260.531341552427, 4253.8723838284905, 4256.87229383119, 4263.488381394237, 4268.78656067197, 4270.0605866709275, 4025.215083058805, 4201.768902710365, 4211.747295162285, 4217.493900731916, 4224.577542245766, 4158.792060396968, 4165.5834416558255, 4168.3955826405, 4179.519355274137, 4186.372044193365, 3587.461880717887, 3589.192431702872, 3589.892303230907, 3597.0827439002887, 3597.80212088335, 5146.485351464861, 5305.204219367087, 5305.973470132663, 5307.65500242483, 5330.253764472977, 4814.422269327703, 4815.49437309081, 4824.951750482521, 4827.300041493999, 4827.565519103297, 5827.0, 5827.242458480413, 5833.941660583382, 5839.386864379221, 5842.065269556893, 3924.4309575111733, 3932.4494570760116, 3935.9016024599327, 3936.9960660031793, 3938.4289278054807, 5863.296404431453, 6129.019356902874, 6129.11127886454, 6133.233345831771, 6145.754169833157, 4057.350823868167, 4063.674906007512, 4066.34938409853, 4073.287174744408, 4081.5918408158946, 4112.9588704112575, 4133.648639865585, 4140.358244472111, 4142.08874047715, 4147.605977432139, 4765.761711914391, 4801.1117943180625, 4802.255650374198, 4808.35087263222, 4815.253635686474, 5670.5463562914865, 5784.1902133701315, 5817.040188368872, 5839.532837373, 5841.532677385799, 1433.5054406229833, 1466.65533599604, 1467.5450610310838, 1470.5147301390516, 1470.647044709262, 925.1349987761464, 961.6153538584482, 967.0957654592978, 970.6651205334149, 983.1201075037801, 5097.413797413271, 5111.693298402108, 5113.897722045613, 5117.974410128, 5160.509751573594, 6079.3920607939735, 6087.086936959403, 6090.056041313604, 6093.603915745551, 6103.816885493442, 5103.0, 5105.285260063594, 5106.540411362921, 5106.719130447861, 5108.591312694975, 3190.6490286068515, 3278.770486066, 3295.4068267711564, 3299.9340013199603, 3308.6856748608843, 5775.0, 5809.593328467051, 5821.941780582225, 5823.155642431823, 5825.679587622722, 6129.969350153221, 6313.715882785285, 6333.904991425133, 6336.049592561153, 6354.078658594478, 5739.540836733135, 5749.390170752113, 5787.826365209135, 5788.5369170466265, 5798.159266906275, 6137.478314343331, 6138.877222455615, 6148.354422785722, 6153.292371377349, 6154.846128846814, 5731.914021289601, 5979.133025711334, 5984.222051133499, 5995.670238136944, 6007.128966299774, 5792.160136780059, 5793.391693872083, 5797.507211886868, 5803.216565763737, 5805.8548536286935, 4030.7984600770433, 4076.490438695163, 4089.304818180976, 4095.24238015968, 4102.159057393287, 5962.55280853929, 6098.451139397475, 6129.478994285536, 6138.508919286357, 6170.784022559189, 5877.4122587740885, 5890.087036509348, 5895.528357731457, 5920.73356698941, 5920.79277225295, 5874.7956668881925, 5894.557908156819, 5896.9115463268945, 5899.793507227227, 5906.2026626406605, 5735.225744524436, 5787.450192231731, 5788.507976822018, 5791.9131213031, 5796.565257605781, 5760.135979603093, 5949.375315591974, 5954.285485741739, 5960.403959604178, 5960.910586341295, 5769.192313076089, 5777.91333129995, 5788.160716696139, 5788.884222315614, 5819.6508209507565], "unit": "ms", "name": "prototype.html", "value": 4344.265713790461}, {"lowerIsBetter": false, "replicates": [671.5936858200788, 679.969401376938, 680.9761658341959, 728.6830228850447, 764.8508540834536, 10619.203559733021, 10864.565417383305, 10876.836847447295, 10878.292910960781, 10935.070519005874, 10820.783584328328, 11741.882581174186, 11847.7630447391, 11852.585159519418, 11911.940440297787, 600.7236671131285, 610.2432983100945, 756.5990025286593, 773.9729109481169, 774.1909704358958, 754.2231501553381, 772.2779201446665, 778.4511919097051, 779.9532028078305, 780.1652232111643, 786.5162924801264, 798.8442253760519, 800.747764454198, 804.9436539442241, 805.6374631415857, 785.3834739729314, 800.1198681450417, 802.546561192927, 803.7709252862965, 806.6249194124701, 587.0753563138032, 589.7316720892027, 595.8152972578514, 596.9850753731148, 597.4175179200245, 10862.72843178919, 10965.177611679077, 10973.615923442641, 10985.61550345742, 11028.28316159447, 10514.579416823319, 10704.732381690443, 10895.455227238606, 11093.278936869077, 11280.774384512264, 9550.761230969281, 9576.521173941344, 9613.855792163124, 9695.369800962915, 9834.901650983471, 3304.322613864152, 3329.8501567429525, 3344.3144155448317, 3394.728421726281, 3395.5585773849243, 39316.41025384593, 39489.21021579581, 39830.40254396186, 40293.59706402928, 40298.19403611941, 9054.773630659287, 9077.228435582918, 9155.633774649074, 9229.215516681157, 9247.76880577991, 15682.137482438575, 15703.450379236672, 15721.292541835644, 15807.13060781645, 15813.0, 6210.223722034746, 6238.719257633417, 6254.061890716429, 6397.072424498515, 6409.455196308366, 3402.2685122698244, 3468.4103702370658, 3586.802725850051, 3659.0669379308106, 3668.4497325401403, 2675.67891852975, 2693.9461210775676, 2704.8647567621933, 2710.241132482908, 2713.240292718042, 476.5568021739815, 486.936698229235, 489.39315249090873, 493.8765308672832, 496.548141191514, 564.3848205456072, 574.8332983434841, 585.8828234353147, 607.8480379905023, 617.9721912513947, 7587.58268295249, 7725.26609972063, 7900.367970562456, 8113.8377232456205, 8156.265936065783, 465.42752414530315, 477.7730577975434, 484.1914003613973, 490.2694984473109, 554.6782865937746, 3479.739019573542, 3529.347070791912, 3622.800745958945, 3703.5370578677666, 3706.79612621303, 47796.522034779904, 47834.28248576274, 48687.756561216964, 48940.51059489431, 48947.510524895006, 42583.78708106501, 42770.35844462336, 43203.56796432058, 43346.133077338905, 43593.34609980853, 39317.41023884644, 39548.406773898416, 39931.80034099869, 40159.0, 40380.79809600992, 7615.885761713689, 7762.5730584818375, 8145.470544414594, 8165.836683266182, 8172.959135204286, 29803.70196298096, 30486.84756576203, 30741.53887691731, 30769.846150769103, 31311.68688313088, 36668.81665591762, 36947.815260923526, 38911.22177556376, 39277.80361098176, 39772.2045559093, 9504.524773761146, 9931.503424828585, 10236.0, 10289.639862604772, 10352.896471035194, 11742.647720568397, 11783.116266280234, 11796.351200684045, 11817.0, 11908.106891982963, 9436.197923176607, 10361.689149325532, 10954.835677465004, 11082.556697732, 11463.197576169589, 9872.062154095349, 10712.0, 11165.162612804235, 11293.153013523854, 11315.547378104784, 10258.846117308098, 10487.94756026215, 10974.890251097706, 11160.10719142483, 11168.162387821108, 8376.623051962555, 8561.61472733716, 8565.357598180286, 8628.78428039304, 8882.111788821325, 8223.712170074019, 8376.874346884924, 8672.52301123419, 8676.436031657922, 9068.455892646462], "unit": "ms", "name": "yui.html", "value": 5601.390829136004}], "name": "dromaeo_css", "value": 6150.425106041478}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 115.0, 114.0, 114.0, 125.0, 113.0, 112.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [156.0, 131.0, 160.0, 173.0, 137.0, 167.0, 163.0, 137.0, 173.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 153.1}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 164.0, 162.0, 161.0, 169.0, 169.0, 168.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.7}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 76.0, 75.0, 132.0, 73.0, 72.0, 80.0, 72.0, 94.0], "unit": "ms", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 135.0, 94.0, 94.0, 95.0, 131.0, 95.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 112.0, 111.0, 111.0, 109.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 149.0, 149.0, 147.0, 151.0, 148.0, 149.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 96.0, 95.0, 95.0, 96.0, 97.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 74.0, 75.0, 75.0, 75.0, 74.0, 75.0, 74.0, 78.0], "unit": "ms", "name": "json-parse-financial", "value": 74.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 68.0, 68.0, 69.0, 69.0, 69.0, 70.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 85.0, 82.0, 83.0, 96.0, 85.0, 95.0, 99.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [122.0, 138.0, 128.0, 119.0, 135.0, 130.0, 127.0, 130.0, 126.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.6}, {"lowerIsBetter": true, "replicates": [136.0, 149.0, 149.0, 148.0, 152.0, 142.0, 152.0, 152.0, 147.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 70.0, 70.0, 71.0, 70.0, 70.0, 69.0, 74.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.0}], "name": "kraken", "value": 1551.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.74789065136684], "unit": "score", "name": "Richards", "value": 209.19965200000001}, {"lowerIsBetter": false, "replicates": [183.58729575913347], "unit": "score", "name": "DeltaBlue", "value": 360.144746}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1075.268817204301], "unit": "score", "name": "RayTrace", "value": 688.1897699999998}, {"lowerIsBetter": false, "replicates": [746.2686567164179], "unit": "score", "name": "Earley", "value": 893.0604200000004}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [25820.51282051282], "unit": "score", "name": "RegExp", "value": 35.28144488579943}, {"lowerIsBetter": false, "replicates": [594.5465323058684], "unit": "score", "name": "Splay", "value": 137.0641246261216}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21284.113424299754}]} 07:08:51 INFO - RETURN: dromaeo_css: 6150.43 07:08:51 INFO - RETURN: kraken: 1551.50 07:08:51 INFO - RETURN: v8_7: 21284.11 07:08:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21284.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1551.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6150.43"}}} 07:08:51 INFO - Return code: 0 07:08:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:08:51 INFO - # TBPL SUCCESS # 07:08:51 INFO - Running post-action listener: _resource_record_post_action 07:08:51 INFO - Running post-run listener: _resource_record_post_run 07:08:52 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 500105216; Read time: 12; Write time: 510736 07:08:52 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 229253120; Read time: 0; Write time: 293452 07:08:52 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 270397440; Read time: 12; Write time: 217252 07:08:52 INFO - Running post-run listener: _upload_blobber_files 07:08:52 INFO - Blob upload gear active. 07:08:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:08:52 INFO - Copying logs to upload dir... 07:08:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.655276 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-11-27 07:08:52.583348) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 07:08:52.586880) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010044 build_url: 'https://queue.taskcluster.net/v1/task/cbe5Z02KRv-fZVmJKVB6DA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 07:08:52.639413) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:08:52.639811) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1448635218.449347-680884232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004660 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 07:08:52.690523) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 07:08:52.690910) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 07:08:52.691349) ========= ========= Total master_lag: 0.24 =========