builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1449082008.14 results: success (0) buildid: 20151202101926 builduid: 53acef5bb1ea446d87c50cb2e790dec0 revision: 0ae21184dbe776ca22e68ff162428ac11348a030 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.141866) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.142293) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.142586) ========= 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=3cd289541638898829117e0a000001bd-1449080384.963748-1575825979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006257 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.167198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.167678) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.195705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.195971) ========= 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=3cd289541638898829117e0a000001bd-1449080384.963748-1575825979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004733 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.245493) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.245974) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.246360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.246627) ========= 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=3cd289541638898829117e0a000001bd-1449080384.963748-1575825979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 10:46:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-02 10:46:48 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.200896 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.469919) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.470230) ========= 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=3cd289541638898829117e0a000001bd-1449080384.963748-1575825979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017766 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.521075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:48.521415) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0ae21184dbe776ca22e68ff162428ac11348a030 --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 0ae21184dbe776ca22e68ff162428ac11348a030 --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=3cd289541638898829117e0a000001bd-1449080384.963748-1575825979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 10:46:48,722 truncating revision to first 12 chars 2015-12-02 10:46:48,722 Setting DEBUG logging. 2015-12-02 10:46:48,722 attempt 1/10 2015-12-02 10:46:48,722 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0ae21184dbe7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 10:46:48,954 unpacking tar archive at: fx-team-0ae21184dbe7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529982 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:49.064391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:49.064672) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:49.077061) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:49.077598) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 10:46:49.078248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-02 10:46:49.078727) ========= /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=3cd289541638898829117e0a000001bd-1449080384.963748-1575825979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:46:49 INFO - MultiFileLogger online at 20151202 10:46:49 in /builds/slave/test 10:46:49 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 10:46:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:46:49 INFO - {'append_to_log': False, 10:46:49 INFO - 'base_work_dir': '/builds/slave/test', 10:46:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:46:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:46:49 INFO - 'branch': 'Fx-Team-Non-PGO', 10:46:49 INFO - 'buildbot_json_path': 'buildprops.json', 10:46:49 INFO - 'config_files': ('talos/linux_config.py',), 10:46:49 INFO - 'default_actions': ('clobber', 10:46:49 INFO - 'read-buildbot-config', 10:46:49 INFO - 'download-and-extract', 10:46:49 INFO - 'populate-webroot', 10:46:49 INFO - 'create-virtualenv', 10:46:49 INFO - 'install', 10:46:49 INFO - 'run-tests'), 10:46:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:46:49 INFO - 'download_minidump_stackwalk': True, 10:46:49 INFO - 'download_symbols': 'ondemand', 10:46:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:46:49 INFO - 'tooltool.py': '/tools/tooltool.py', 10:46:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:46:49 INFO - '/tools/misc-python/virtualenv.py')}, 10:46:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:46:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:46:49 INFO - 'installer_path': 'installer.exe', 10:46:49 INFO - 'log_level': 'info', 10:46:49 INFO - 'log_name': 'talos', 10:46:49 INFO - 'log_to_console': True, 10:46:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:46:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:46:49 INFO - 'opt_config_files': (), 10:46:49 INFO - 'pip_index': False, 10:46:49 INFO - 'sps_profile': False, 10:46:49 INFO - 'sps_profile_interval': 0, 10:46:49 INFO - 'suite': 'dromaeojs-e10s', 10:46:49 INFO - 'system_bits': '64', 10:46:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:46:49 INFO - 'title': 'talos-linux64-ix-025', 10:46:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:46:49 INFO - 'use_talos_json': True, 10:46:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:46:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:46:49 INFO - 'work_dir': 'build'} 10:46:49 INFO - ##### 10:46:49 INFO - ##### Running clobber step. 10:46:49 INFO - ##### 10:46:49 INFO - Running pre-action listener: _resource_record_pre_action 10:46:49 INFO - Running main action method: clobber 10:46:49 INFO - rmtree: /builds/slave/test/build 10:46:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:46:49 INFO - Running post-action listener: _resource_record_post_action 10:46:49 INFO - ##### 10:46:49 INFO - ##### Running read-buildbot-config step. 10:46:49 INFO - ##### 10:46:49 INFO - Running pre-action listener: _resource_record_pre_action 10:46:49 INFO - Running main action method: read_buildbot_config 10:46:49 INFO - Using buildbot properties: 10:46:49 INFO - { 10:46:49 INFO - "properties": { 10:46:49 INFO - "buildnumber": 501, 10:46:49 INFO - "product": "firefox", 10:46:49 INFO - "script_repo_revision": "production", 10:46:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:46:49 INFO - "repository": "", 10:46:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:46:49 INFO - "buildid": "20151202101926", 10:46:49 INFO - "slavename": "talos-linux64-ix-025", 10:46:49 INFO - "pgo_build": "False", 10:46:49 INFO - "basedir": "/builds/slave/test", 10:46:49 INFO - "project": "", 10:46:49 INFO - "platform": "ubuntu64_hw", 10:46:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:46:49 INFO - "slavebuilddir": "test", 10:46:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:46:49 INFO - "branch": "fx-team", 10:46:49 INFO - "repo_path": "integration/fx-team", 10:46:49 INFO - "stage_platform": "linux64", 10:46:49 INFO - "builduid": "53acef5bb1ea446d87c50cb2e790dec0", 10:46:49 INFO - "revision": "0ae21184dbe776ca22e68ff162428ac11348a030" 10:46:49 INFO - }, 10:46:49 INFO - "sourcestamp": { 10:46:49 INFO - "repository": "", 10:46:49 INFO - "hasPatch": false, 10:46:49 INFO - "project": "", 10:46:49 INFO - "branch": "fx-team-linux64-talos", 10:46:49 INFO - "changes": [ 10:46:49 INFO - { 10:46:49 INFO - "category": null, 10:46:49 INFO - "files": [ 10:46:49 INFO - { 10:46:49 INFO - "url": null, 10:46:49 INFO - "name": "https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:46:49 INFO - } 10:46:49 INFO - ], 10:46:49 INFO - "repository": "", 10:46:49 INFO - "rev": "0ae21184dbe776ca22e68ff162428ac11348a030", 10:46:49 INFO - "who": "dtownsend@mozilla.com", 10:46:49 INFO - "when": 1449081966, 10:46:49 INFO - "number": 6734241, 10:46:49 INFO - "comments": "Bug 1229097: Fix missed review comment by converting all rules to errors.", 10:46:49 INFO - "project": "", 10:46:49 INFO - "at": "Wed 02 Dec 2015 10:46:06", 10:46:49 INFO - "branch": "fx-team-linux64-talos", 10:46:49 INFO - "revlink": "", 10:46:49 INFO - "properties": [ 10:46:49 INFO - [ 10:46:49 INFO - "buildid", 10:46:49 INFO - "20151202101926", 10:46:49 INFO - "Change" 10:46:49 INFO - ], 10:46:49 INFO - [ 10:46:49 INFO - "builduid", 10:46:49 INFO - "53acef5bb1ea446d87c50cb2e790dec0", 10:46:49 INFO - "Change" 10:46:49 INFO - ], 10:46:49 INFO - [ 10:46:49 INFO - "pgo_build", 10:46:49 INFO - "False", 10:46:49 INFO - "Change" 10:46:49 INFO - ] 10:46:49 INFO - ], 10:46:49 INFO - "revision": "0ae21184dbe776ca22e68ff162428ac11348a030" 10:46:49 INFO - } 10:46:49 INFO - ], 10:46:49 INFO - "revision": "0ae21184dbe776ca22e68ff162428ac11348a030" 10:46:49 INFO - } 10:46:49 INFO - } 10:46:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:46:49 INFO - Running post-action listener: _resource_record_post_action 10:46:49 INFO - ##### 10:46:49 INFO - ##### Running download-and-extract step. 10:46:49 INFO - ##### 10:46:49 INFO - Running pre-action listener: _resource_record_pre_action 10:46:49 INFO - Running main action method: download_and_extract 10:46:49 INFO - mkdir: /builds/slave/test/build/tests 10:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:49 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:46:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json 10:46:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json 10:46:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:46:57 INFO - Downloaded 1302 bytes. 10:46:57 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:46:57 INFO - Using the following test package requirements: 10:46:57 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:57 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:46:57 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:57 INFO - u'jsshell-linux-x86_64.zip'], 10:46:57 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:46:57 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:57 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:46:57 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:46:57 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:46:57 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:57 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:57 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:46:57 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:46: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')]} 10:46:57 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:46:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/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 10:46:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/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 10:47:01 INFO - Downloaded 21774978 bytes. 10:47:01 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 10:47:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:47:01 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 10:47:02 INFO - Return code: 0 10:47:02 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 10:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:02 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:47:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:47:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:47:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/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 10:47:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/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 10:47:07 INFO - Downloaded 21774978 bytes. 10:47:07 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 10:47:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:47:07 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 10:47:08 INFO - Return code: 0 10:47: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')]} 10:47:08 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:47:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:47:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:47:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/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 10:47:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/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 10:47:09 INFO - Downloaded 11132001 bytes. 10:47:09 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 10:47:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:47:09 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 10:47:09 INFO - Return code: 0 10:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:09 INFO - https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:47:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/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 10:47:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/skZSyFHZTxmczj5dQAaKDA/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 10:47:10 INFO - Downloaded 57678286 bytes. 10:47:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:10 INFO - mkdir: /builds/slave/test/properties 10:47:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:47:10 INFO - Writing to file /builds/slave/test/properties/build_url 10:47:10 INFO - Contents: 10:47:10 INFO - build_url:https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:10 INFO - Running post-action listener: _resource_record_post_action 10:47:10 INFO - Running post-action listener: set_extra_try_arguments 10:47:10 INFO - ##### 10:47:10 INFO - ##### Running populate-webroot step. 10:47:10 INFO - ##### 10:47:10 INFO - Running pre-action listener: _resource_record_pre_action 10:47:10 INFO - Running main action method: populate_webroot 10:47:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:47:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:47:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:47:10 INFO - '../fennec_ids.txt'], 10:47:10 INFO - 'tests': ['tcheck2']}, 10:47:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:47:10 INFO - '--tppagecycles', 10:47:10 INFO - '7'], 10:47:10 INFO - 'tests': ['tsvgm']}}, 10:47:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:47:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:47:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:47:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:47:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:47:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:47:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:10 INFO - 'talos_options': ['--e10s'], 10:47:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:10 INFO - 'tests': ['damp', 'tps']}, 10:47:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:10 INFO - 'talos_options': ['--e10s'], 10:47:10 INFO - 'tests': ['damp', 'tps']}, 10:47:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:47:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:47:10 INFO - 'other': {'tests': ['a11yr', 10:47:10 INFO - 'ts_paint', 10:47:10 INFO - 'tpaint', 10:47:10 INFO - 'sessionrestore', 10:47:10 INFO - 'sessionrestore_no_auto_restore']}, 10:47:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:47:10 INFO - 'tests': ['a11yr', 10:47:10 INFO - 'ts_paint', 10:47:10 INFO - 'tpaint', 10:47:10 INFO - 'sessionrestore', 10:47:10 INFO - 'sessionrestore_no_auto_restore']}, 10:47:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:47:10 INFO - 'tests': ['a11yr', 10:47:10 INFO - 'ts_paint', 10:47:10 INFO - 'tpaint', 10:47:10 INFO - 'sessionrestore', 10:47:10 INFO - 'sessionrestore_no_auto_restore']}, 10:47:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:47:10 INFO - 'tests': ['a11yr', 10:47:10 INFO - 'ts_paint', 10:47:10 INFO - 'tpaint', 10:47:10 INFO - 'sessionrestore', 10:47:10 INFO - 'sessionrestore_no_auto_restore']}, 10:47:10 INFO - 'other_l64': {'tests': ['a11yr', 10:47:10 INFO - 'ts_paint', 10:47:10 INFO - 'tpaint', 10:47:10 INFO - 'sessionrestore', 10:47:10 INFO - 'sessionrestore_no_auto_restore']}, 10:47:10 INFO - 'other_nol64': {'tests': ['a11yr', 10:47:10 INFO - 'ts_paint', 10:47:10 INFO - 'tpaint', 10:47:10 INFO - 'sessionrestore', 10:47:10 INFO - 'sessionrestore_no_auto_restore']}, 10:47:10 INFO - 'svgr': {'tests': ['tsvgx', 10:47:10 INFO - 'tsvgr_opacity', 10:47:10 INFO - 'tart', 10:47:10 INFO - 'tscrollx', 10:47:10 INFO - 'cart']}, 10:47:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:47:10 INFO - 'tests': ['tsvgx', 10:47:10 INFO - 'tsvgr_opacity', 10:47:10 INFO - 'tart', 10:47:10 INFO - 'tscrollx', 10:47:10 INFO - 'cart']}, 10:47:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:10 INFO - 'tests': ['tp5o']}, 10:47:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:10 INFO - 'talos_options': ['--e10s'], 10:47:10 INFO - 'tests': ['tp5o']}, 10:47:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:10 INFO - 'talos_options': ['--xperf_path', 10:47:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:10 INFO - 'tests': ['tp5n']}, 10:47:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:10 INFO - 'talos_options': ['--e10s', 10:47:10 INFO - '--xperf_path', 10:47:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:10 INFO - 'tests': ['tp5n']}}, 10:47:10 INFO - 'talos.zip': {'path': '', 10:47:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:47:10 INFO - Running post-action listener: _resource_record_post_action 10:47:10 INFO - ##### 10:47:10 INFO - ##### Running create-virtualenv step. 10:47:10 INFO - ##### 10:47:10 INFO - Running pre-action listener: _resource_record_pre_action 10:47:10 INFO - Running main action method: create_virtualenv 10:47:10 INFO - Creating virtualenv /builds/slave/test/build/venv 10:47:10 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 10:47:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:47:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:47:11 INFO - Using real prefix '/usr' 10:47:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:47:11 INFO - Installing distribute.............................................................................................................................................................................................done. 10:47:13 INFO - Installing pip.................done. 10:47:13 INFO - Return code: 0 10:47:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f729d6f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, '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': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', '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 10:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:47:13 INFO - Using env: {'DISPLAY': ':0', 10:47:13 INFO - 'HOME': '/home/cltbld', 10:47:13 INFO - 'LANG': 'en_US.UTF-8', 10:47:13 INFO - 'LANGUAGE': 'en_US:en', 10:47:13 INFO - 'LOGNAME': 'cltbld', 10:47:13 INFO - 'MAIL': '/var/mail/cltbld', 10:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:13 INFO - 'MOZ_NO_REMOTE': '1', 10:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:13 INFO - 'NO_EM_RESTART': '1', 10:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:13 INFO - 'PWD': '/builds/slave/test', 10:47:13 INFO - 'SHELL': '/bin/bash', 10:47:13 INFO - 'SHLVL': '1', 10:47:13 INFO - 'TERM': 'linux', 10:47:13 INFO - 'TMOUT': '86400', 10:47:13 INFO - 'USER': 'cltbld', 10:47:13 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:13 INFO - '_': '/tools/buildbot/bin/python'} 10:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:13 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 10:47:13 INFO - Cleaning up... 10:47:13 INFO - Return code: 0 10:47:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f729d6f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, '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': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', '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 10:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:47:13 INFO - Using env: {'DISPLAY': ':0', 10:47:13 INFO - 'HOME': '/home/cltbld', 10:47:13 INFO - 'LANG': 'en_US.UTF-8', 10:47:13 INFO - 'LANGUAGE': 'en_US:en', 10:47:13 INFO - 'LOGNAME': 'cltbld', 10:47:13 INFO - 'MAIL': '/var/mail/cltbld', 10:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:13 INFO - 'MOZ_NO_REMOTE': '1', 10:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:13 INFO - 'NO_EM_RESTART': '1', 10:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:13 INFO - 'PWD': '/builds/slave/test', 10:47:13 INFO - 'SHELL': '/bin/bash', 10:47:13 INFO - 'SHLVL': '1', 10:47:13 INFO - 'TERM': 'linux', 10:47:13 INFO - 'TMOUT': '86400', 10:47:13 INFO - 'USER': 'cltbld', 10:47:13 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:13 INFO - '_': '/tools/buildbot/bin/python'} 10:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:14 INFO - Downloading/unpacking psutil>=0.7.1 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:47:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:47:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:15 INFO - Installing collected packages: psutil 10:47:15 INFO - Running setup.py install for psutil 10:47:15 INFO - building 'psutil._psutil_linux' extension 10:47:15 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 10:47:16 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 10:47:16 INFO - building 'psutil._psutil_posix' extension 10:47:16 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 10:47:16 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 10:47:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:16 INFO - Successfully installed psutil 10:47:16 INFO - Cleaning up... 10:47:16 INFO - Return code: 0 10:47:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:47:16 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')]} 10:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:16 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')]} 10:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:16 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 0x7f729d6f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, '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': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', '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 10:47:16 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 10:47:16 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 10:47:16 INFO - Using env: {'DISPLAY': ':0', 10:47:16 INFO - 'HOME': '/home/cltbld', 10:47:16 INFO - 'LANG': 'en_US.UTF-8', 10:47:16 INFO - 'LANGUAGE': 'en_US:en', 10:47:16 INFO - 'LOGNAME': 'cltbld', 10:47:16 INFO - 'MAIL': '/var/mail/cltbld', 10:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:16 INFO - 'MOZ_NO_REMOTE': '1', 10:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:16 INFO - 'NO_EM_RESTART': '1', 10:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:16 INFO - 'PWD': '/builds/slave/test', 10:47:16 INFO - 'SHELL': '/bin/bash', 10:47:16 INFO - 'SHLVL': '1', 10:47:16 INFO - 'TERM': 'linux', 10:47:16 INFO - 'TMOUT': '86400', 10:47:16 INFO - 'USER': 'cltbld', 10:47:16 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:16 INFO - '_': '/tools/buildbot/bin/python'} 10:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47: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 10:47:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:47:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:47:18 INFO - Installing collected packages: mozsystemmonitor 10:47:18 INFO - Running setup.py install for mozsystemmonitor 10:47:18 INFO - Successfully installed mozsystemmonitor 10:47:18 INFO - Cleaning up... 10:47:18 INFO - Return code: 0 10:47:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:47:18 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')]} 10:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 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')]} 10:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 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 0x7f729d6f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, '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': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', '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 10:47:18 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 10:47:18 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 10:47:18 INFO - Using env: {'DISPLAY': ':0', 10:47:18 INFO - 'HOME': '/home/cltbld', 10:47:18 INFO - 'LANG': 'en_US.UTF-8', 10:47:18 INFO - 'LANGUAGE': 'en_US:en', 10:47:18 INFO - 'LOGNAME': 'cltbld', 10:47:18 INFO - 'MAIL': '/var/mail/cltbld', 10:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:18 INFO - 'MOZ_NO_REMOTE': '1', 10:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:18 INFO - 'NO_EM_RESTART': '1', 10:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:18 INFO - 'PWD': '/builds/slave/test', 10:47:18 INFO - 'SHELL': '/bin/bash', 10:47:18 INFO - 'SHLVL': '1', 10:47:18 INFO - 'TERM': 'linux', 10:47:18 INFO - 'TMOUT': '86400', 10:47:18 INFO - 'USER': 'cltbld', 10:47:18 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:18 INFO - '_': '/tools/buildbot/bin/python'} 10:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:18 INFO - Downloading/unpacking blobuploader==1.2.4 10:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:20 INFO - Downloading blobuploader-1.2.4.tar.gz 10:47:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:47:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:47:20 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 10:47:20 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 10:47:20 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 10:47:20 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 10:47:20 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 10:47:20 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 10:47:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:47:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:47:20 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 10:47:20 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 10:47:20 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 10:47:20 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 10:47:20 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 10:47:20 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 10:47:20 INFO - Downloading docopt-0.6.1.tar.gz 10:47:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:21 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:21 INFO - Running setup.py install for blobuploader 10:47:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:47:21 INFO - Running setup.py install for requests 10:47:21 INFO - Running setup.py install for docopt 10:47:21 INFO - Successfully installed blobuploader requests docopt 10:47:21 INFO - Cleaning up... 10:47:21 INFO - Return code: 0 10:47:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:21 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 0x7f729d6f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, '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': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', '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 10:47:21 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 10:47:21 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 10:47:21 INFO - Using env: {'DISPLAY': ':0', 10:47:21 INFO - 'HOME': '/home/cltbld', 10:47:21 INFO - 'LANG': 'en_US.UTF-8', 10:47:21 INFO - 'LANGUAGE': 'en_US:en', 10:47:21 INFO - 'LOGNAME': 'cltbld', 10:47:21 INFO - 'MAIL': '/var/mail/cltbld', 10:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:21 INFO - 'MOZ_NO_REMOTE': '1', 10:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:21 INFO - 'NO_EM_RESTART': '1', 10:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:21 INFO - 'PWD': '/builds/slave/test', 10:47:21 INFO - 'SHELL': '/bin/bash', 10:47:21 INFO - 'SHLVL': '1', 10:47:21 INFO - 'TERM': 'linux', 10:47:21 INFO - 'TMOUT': '86400', 10:47:21 INFO - 'USER': 'cltbld', 10:47:21 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:21 INFO - '_': '/tools/buildbot/bin/python'} 10:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:21 INFO - Running setup.py (path:/tmp/pip-dPF_0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:21 INFO - Running setup.py (path:/tmp/pip-F9fbj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:21 INFO - Running setup.py (path:/tmp/pip-S0Jowc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:22 INFO - Running setup.py (path:/tmp/pip-Y5cwkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:22 INFO - Running setup.py (path:/tmp/pip-vZdJAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:22 INFO - Running setup.py (path:/tmp/pip-sgTh0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:22 INFO - Running setup.py (path:/tmp/pip-pjOTd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:22 INFO - Running setup.py (path:/tmp/pip-lCqLKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:22 INFO - Running setup.py (path:/tmp/pip-6qGQy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:22 INFO - Running setup.py (path:/tmp/pip-sKxzRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:22 INFO - Running setup.py (path:/tmp/pip-rt2kWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:22 INFO - Running setup.py (path:/tmp/pip-Og4do3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:22 INFO - Running setup.py (path:/tmp/pip-B6r4SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:22 INFO - Running setup.py (path:/tmp/pip-HnwDph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:22 INFO - Running setup.py (path:/tmp/pip-kFrXbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:22 INFO - Running setup.py (path:/tmp/pip-Ko9LoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:22 INFO - Running setup.py (path:/tmp/pip-dOJLsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:23 INFO - Running setup.py install for manifestparser 10:47:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:47:23 INFO - Running setup.py install for mozcrash 10:47:23 INFO - Running setup.py install for mozdebug 10:47:23 INFO - Running setup.py install for mozdevice 10:47:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:47:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:47:23 INFO - Running setup.py install for mozfile 10:47:23 INFO - Running setup.py install for mozhttpd 10:47:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:47:23 INFO - Running setup.py install for mozinfo 10:47:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:47:23 INFO - Running setup.py install for mozInstall 10:47:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:47:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:47:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:47:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:47:23 INFO - Running setup.py install for mozleak 10:47:23 INFO - Running setup.py install for mozlog 10:47:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:47:24 INFO - Running setup.py install for moznetwork 10:47:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:47:24 INFO - Running setup.py install for mozprocess 10:47:24 INFO - Running setup.py install for mozprofile 10:47:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:47:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:47:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:47:24 INFO - Running setup.py install for mozrunner 10:47:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:47:24 INFO - Running setup.py install for mozscreenshot 10:47:24 INFO - Running setup.py install for moztest 10:47:24 INFO - Running setup.py install for mozversion 10:47:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:47:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:24 INFO - Cleaning up... 10:47:24 INFO - Return code: 0 10:47:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f729d6f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, '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': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', '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 10:47:24 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 10:47:24 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 10:47:24 INFO - Using env: {'DISPLAY': ':0', 10:47:24 INFO - 'HOME': '/home/cltbld', 10:47:24 INFO - 'LANG': 'en_US.UTF-8', 10:47:24 INFO - 'LANGUAGE': 'en_US:en', 10:47:24 INFO - 'LOGNAME': 'cltbld', 10:47:24 INFO - 'MAIL': '/var/mail/cltbld', 10:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:24 INFO - 'MOZ_NO_REMOTE': '1', 10:47:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:24 INFO - 'NO_EM_RESTART': '1', 10:47:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:24 INFO - 'PWD': '/builds/slave/test', 10:47:24 INFO - 'SHELL': '/bin/bash', 10:47:24 INFO - 'SHLVL': '1', 10:47:24 INFO - 'TERM': 'linux', 10:47:24 INFO - 'TMOUT': '86400', 10:47:24 INFO - 'USER': 'cltbld', 10:47:24 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:24 INFO - '_': '/tools/buildbot/bin/python'} 10:47:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:25 INFO - Running setup.py (path:/tmp/pip-k9bRdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:25 INFO - Running setup.py (path:/tmp/pip-dzOiI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:25 INFO - Running setup.py (path:/tmp/pip-sd7SP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:25 INFO - Running setup.py (path:/tmp/pip-oJUx3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:25 INFO - Running setup.py (path:/tmp/pip-9jiBhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:25 INFO - Running setup.py (path:/tmp/pip-29Yx7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:25 INFO - Running setup.py (path:/tmp/pip-sv5Da_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:25 INFO - Running setup.py (path:/tmp/pip-025Oh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:25 INFO - Running setup.py (path:/tmp/pip-Ndxou4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:25 INFO - Running setup.py (path:/tmp/pip-sLqXnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:25 INFO - Running setup.py (path:/tmp/pip-8QmZ1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:25 INFO - Running setup.py (path:/tmp/pip-foHkTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:25 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)) 10:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:25 INFO - Running setup.py (path:/tmp/pip-8qElPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:26 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)) 10:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:26 INFO - Running setup.py (path:/tmp/pip-bkCIbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:26 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)) 10:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:26 INFO - Running setup.py (path:/tmp/pip-aRqoq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:26 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)) 10:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:26 INFO - Running setup.py (path:/tmp/pip-8lV0CH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:26 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)) 10:47:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:26 INFO - Running setup.py (path:/tmp/pip-RQmMus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:26 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)) 10:47:26 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)) 10:47:26 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)) 10:47:26 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)) 10:47:26 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)) 10:47:26 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)) 10:47:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:27 INFO - Downloading blessings-1.5.1.tar.gz 10:47:27 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 10:47:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:47:28 INFO - Installing collected packages: blessings 10:47:28 INFO - Running setup.py install for blessings 10:47:28 INFO - Successfully installed blessings 10:47:28 INFO - Cleaning up... 10:47:28 INFO - Return code: 0 10:47:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:47:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:28 INFO - Reading from file tmpfile_stdout 10:47:28 INFO - Current package versions: 10:47:28 INFO - argparse == 1.2.1 10:47:28 INFO - blessings == 1.5.1 10:47:28 INFO - blobuploader == 1.2.4 10:47:28 INFO - docopt == 0.6.1 10:47:28 INFO - manifestparser == 1.1 10:47:28 INFO - mozInstall == 1.12 10:47:28 INFO - mozcrash == 0.16 10:47:28 INFO - mozdebug == 0.1 10:47:28 INFO - mozdevice == 0.47 10:47:28 INFO - mozfile == 1.2 10:47:28 INFO - mozhttpd == 0.7 10:47:28 INFO - mozinfo == 0.9 10:47:28 INFO - mozleak == 0.1 10:47:28 INFO - mozlog == 3.1 10:47:28 INFO - moznetwork == 0.27 10:47:28 INFO - mozprocess == 0.22 10:47:28 INFO - mozprofile == 0.27 10:47:28 INFO - mozrunner == 6.11 10:47:28 INFO - mozscreenshot == 0.1 10:47:28 INFO - mozsystemmonitor == 0.0 10:47:28 INFO - moztest == 0.7 10:47:28 INFO - mozversion == 1.4 10:47:28 INFO - psutil == 3.1.1 10:47:28 INFO - requests == 1.2.3 10:47:28 INFO - wsgiref == 0.1.2 10:47:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:28 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')]} 10:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:28 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')]} 10:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:28 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 0x7f729d6f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, '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': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', '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 10:47:28 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 10:47:28 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 10:47:28 INFO - Using env: {'DISPLAY': ':0', 10:47:28 INFO - 'HOME': '/home/cltbld', 10:47:28 INFO - 'LANG': 'en_US.UTF-8', 10:47:28 INFO - 'LANGUAGE': 'en_US:en', 10:47:28 INFO - 'LOGNAME': 'cltbld', 10:47:28 INFO - 'MAIL': '/var/mail/cltbld', 10:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:28 INFO - 'MOZ_NO_REMOTE': '1', 10:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:28 INFO - 'NO_EM_RESTART': '1', 10:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:28 INFO - 'PWD': '/builds/slave/test', 10:47:28 INFO - 'SHELL': '/bin/bash', 10:47:28 INFO - 'SHLVL': '1', 10:47:28 INFO - 'TERM': 'linux', 10:47:28 INFO - 'TMOUT': '86400', 10:47:28 INFO - 'USER': 'cltbld', 10:47:28 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:28 INFO - '_': '/tools/buildbot/bin/python'} 10:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:28 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)) 10:47:28 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)) 10:47:28 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)) 10:47:28 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)) 10:47:28 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)) 10:47:28 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)) 10:47:28 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)) 10:47:28 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)) 10:47:28 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)) 10:47:28 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)) 10:47:28 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)) 10:47:28 INFO - Cleaning up... 10:47:28 INFO - Return code: 0 10:47:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:47:28 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')]} 10:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:28 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')]} 10:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:28 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 0x7f729d6f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, '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': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', '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 10:47:28 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 10:47:28 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 10:47:28 INFO - Using env: {'DISPLAY': ':0', 10:47:28 INFO - 'HOME': '/home/cltbld', 10:47:28 INFO - 'LANG': 'en_US.UTF-8', 10:47:28 INFO - 'LANGUAGE': 'en_US:en', 10:47:28 INFO - 'LOGNAME': 'cltbld', 10:47:28 INFO - 'MAIL': '/var/mail/cltbld', 10:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:28 INFO - 'MOZ_NO_REMOTE': '1', 10:47:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:28 INFO - 'NO_EM_RESTART': '1', 10:47:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:28 INFO - 'PWD': '/builds/slave/test', 10:47:28 INFO - 'SHELL': '/bin/bash', 10:47:28 INFO - 'SHLVL': '1', 10:47:28 INFO - 'TERM': 'linux', 10:47:28 INFO - 'TMOUT': '86400', 10:47:28 INFO - 'USER': 'cltbld', 10:47:28 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:28 INFO - '_': '/tools/buildbot/bin/python'} 10:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:28 INFO - Downloading/unpacking jsonschema 10:47:28 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 10:47:28 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 10:47:28 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 10:47:28 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 10:47:28 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 10:47:28 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 10:47:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:47:30 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 10:47:30 INFO - Downloading/unpacking functools32 (from jsonschema) 10:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:30 INFO - Downloading functools32-3.2.3-2.tar.gz 10:47:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:47:30 INFO - warning: no files found matching '*.txt' 10:47:30 INFO - no previously-included directories found matching 'build' 10:47:30 INFO - no previously-included directories found matching 'dist' 10:47:30 INFO - no previously-included directories found matching '.git*' 10:47:30 INFO - Installing collected packages: jsonschema, functools32 10:47:30 INFO - Running setup.py install for functools32 10:47:31 INFO - warning: no files found matching '*.txt' 10:47:31 INFO - no previously-included directories found matching 'build' 10:47:31 INFO - no previously-included directories found matching 'dist' 10:47:31 INFO - no previously-included directories found matching '.git*' 10:47:31 INFO - Successfully installed jsonschema functools32 10:47:31 INFO - Cleaning up... 10:47:31 INFO - Return code: 0 10:47:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:47: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')]} 10:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:31 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 0x7f729d6f5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, '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': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', '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 10:47:31 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 10:47:31 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 10:47:31 INFO - Using env: {'DISPLAY': ':0', 10:47:31 INFO - 'HOME': '/home/cltbld', 10:47:31 INFO - 'LANG': 'en_US.UTF-8', 10:47:31 INFO - 'LANGUAGE': 'en_US:en', 10:47:31 INFO - 'LOGNAME': 'cltbld', 10:47:31 INFO - 'MAIL': '/var/mail/cltbld', 10:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:31 INFO - 'MOZ_NO_REMOTE': '1', 10:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:31 INFO - 'NO_EM_RESTART': '1', 10:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:31 INFO - 'PWD': '/builds/slave/test', 10:47:31 INFO - 'SHELL': '/bin/bash', 10:47:31 INFO - 'SHLVL': '1', 10:47:31 INFO - 'TERM': 'linux', 10:47:31 INFO - 'TMOUT': '86400', 10:47:31 INFO - 'USER': 'cltbld', 10:47:31 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:31 INFO - '_': '/tools/buildbot/bin/python'} 10:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:31 INFO - Downloading/unpacking flake8 10:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:47:33 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 10:47:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:47:33 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 10:47:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:33 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 10:47:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:47:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:47:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:47:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:47:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:47:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:47:33 INFO - no previously-included directories found matching 'docs/_build' 10:47:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:47:33 INFO - Running setup.py install for pep8 10:47:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:47:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:47:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:47:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:47:33 INFO - no previously-included directories found matching 'docs/_build' 10:47:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:47:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:47:33 INFO - Cleaning up... 10:47:33 INFO - Return code: 0 10:47:33 INFO - Running post-action listener: _resource_record_post_action 10:47:33 INFO - Running post-action listener: _start_resource_monitoring 10:47:33 INFO - Starting resource monitoring. 10:47:33 INFO - ##### 10:47:33 INFO - ##### Running install step. 10:47:33 INFO - ##### 10:47:33 INFO - Running pre-action listener: _resource_record_pre_action 10:47:33 INFO - Running main action method: install 10:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:34 INFO - Reading from file tmpfile_stdout 10:47:34 INFO - Detecting whether we're running mozinstall >=1.0... 10:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:47:34 INFO - Reading from file tmpfile_stdout 10:47:34 INFO - Output received: 10:47:34 INFO - Usage: mozinstall [options] installer 10:47:34 INFO - Options: 10:47:34 INFO - -h, --help show this help message and exit 10:47:34 INFO - -d DEST, --destination=DEST 10:47:34 INFO - Directory to install application into. [default: 10:47:34 INFO - "/builds/slave/test"] 10:47:34 INFO - --app=APP Application being installed. [default: firefox] 10:47:34 INFO - mkdir: /builds/slave/test/build/application 10:47:34 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'] 10:47:34 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 10:47:48 INFO - Reading from file tmpfile_stdout 10:47:48 INFO - Output received: 10:47:48 INFO - /builds/slave/test/build/application/firefox/firefox 10:47:48 INFO - Running post-action listener: _resource_record_post_action 10:47:48 INFO - ##### 10:47:48 INFO - ##### Running run-tests step. 10:47:48 INFO - ##### 10:47:48 INFO - Running pre-action listener: _resource_record_pre_action 10:47:48 INFO - Running main action method: run_tests 10:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:47:48 INFO - Python 2.7.3 10:47:48 INFO - Return code: 0 10:47:48 INFO - grabbing minidump binary from tooltool 10:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:48 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 0x26f70b0>, '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 0x26f7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f8440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:47:48 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 10:47:48 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 10:47:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:47:48 INFO - Return code: 0 10:47:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:47:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:47:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:47:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:47:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:47:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:47:49 INFO - Return code: 0 10:47:49 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/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] in /builds/slave/test/build 10:47:49 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/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost 10:47:49 INFO - Using env: {'DISPLAY': ':0', 10:47:49 INFO - 'HOME': '/home/cltbld', 10:47:49 INFO - 'LANG': 'en_US.UTF-8', 10:47:49 INFO - 'LANGUAGE': 'en_US:en', 10:47:49 INFO - 'LOGNAME': 'cltbld', 10:47:49 INFO - 'MAIL': '/var/mail/cltbld', 10:47:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:47:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:49 INFO - 'MOZ_NO_REMOTE': '1', 10:47:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:47:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:49 INFO - 'NO_EM_RESTART': '1', 10:47:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:49 INFO - 'PWD': '/builds/slave/test', 10:47:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:47:49 INFO - 'SHELL': '/bin/bash', 10:47:49 INFO - 'SHLVL': '1', 10:47:49 INFO - 'TERM': 'linux', 10:47:49 INFO - 'TMOUT': '86400', 10:47:49 INFO - 'USER': 'cltbld', 10:47:49 INFO - 'XDG_SESSION_COOKIE': '3cd289541638898829117e0a000001bd-1449080384.963748-1575825979', 10:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:49 INFO - '_': '/tools/buildbot/bin/python'} 10:47:49 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/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost'] with output_timeout 3600 10:47:49 INFO - mozversion INFO | application_buildid: 20151202101926 10:47:49 INFO - mozversion INFO | application_changeset: 0ae21184dbe776ca22e68ff162428ac11348a030 10:47:49 INFO - mozversion INFO | application_display_name: Nightly 10:47:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:47:49 INFO - mozversion INFO | application_name: Firefox 10:47:49 INFO - mozversion INFO | application_remotingname: firefox 10:47:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:47:49 INFO - mozversion INFO | application_vendor: Mozilla 10:47:49 INFO - mozversion INFO | application_version: 45.0a1 10:47:49 INFO - mozversion INFO | platform_buildid: 20151202101926 10:47:49 INFO - mozversion INFO | platform_changeset: 0ae21184dbe776ca22e68ff162428ac11348a030 10:47:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:47:49 INFO - mozversion INFO | platform_version: 45.0a1 10:47:49 INFO - 2015-12-02 10:47:49,952 DEBUG : using testdate: 1449082069 10:47:49 INFO - 2015-12-02 10:47:49,952 DEBUG : actual date: 1449082069 10:47:50 INFO - 2015-12-02 10:47:50,003 INFO : starting webserver on 'localhost:41699' 10:47:50 INFO - 2015-12-02 10:47:50,004 INFO : Starting test suite talos-linux64-ix-025.e 10:47:50 INFO - 2015-12-02 10:47:50,004 INFO : Starting test dromaeo_css 10:47:50 INFO - 2015-12-02 10:47:50,004 DEBUG : operating with platform_type : linux_ 10:47:50 INFO - 2015-12-02 10:47:50,005 INFO : Initialising browser for dromaeo_css test... 10:47:50 INFO - 2015-12-02 10:47:50,021 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF4sCkx/profile http://localhost:41699/getInfo.html 10:47:54 INFO - 2015-12-02 10:47:54,977 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:47:54 INFO - 2015-12-02 10:47:54,978 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:47:54 INFO - 2015-12-02 10:47:54,978 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:47:54 INFO - 2015-12-02 10:47:54,978 DEBUG : BROWSER_OUTPUT: __metrics 10:47:55 INFO - 2015-12-02 10:47:55,094 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:47:56 INFO - 2015-12-02 10:47:56,021 INFO : Browser initialized. 10:47:56 INFO - 2015-12-02 10:47:56,022 INFO : Running cycle 1/1 for dromaeo_css test... 10:47:56 INFO - 2015-12-02 10:47:56,022 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF4sCkx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:48:07 INFO - 2015-12-02 10:48:07,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 143179776 10:48:07 INFO - 2015-12-02 10:48:07,985 DEBUG : BROWSER_OUTPUT: 10:48:57 INFO - 2015-12-02 10:48:57,630 DEBUG : BROWSER_OUTPUT: 1449082137626 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:51:09 INFO - 2015-12-02 10:51:09,508 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41699/tests/dromaeo/cssquery-ext.html) 10:51:10 INFO - 2015-12-02 10:51:10,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 145682432 10:51:10 INFO - 2015-12-02 10:51:10,513 DEBUG : BROWSER_OUTPUT: 10:54:12 INFO - 2015-12-02 10:54:12,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/dromaeo/cssquery-ext.html (next: http://localhost:41699/tests/dromaeo/cssquery-jquery.html) 10:54:13 INFO - 2015-12-02 10:54:13,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 144609280 10:54:13 INFO - 2015-12-02 10:54:13,131 DEBUG : BROWSER_OUTPUT: 10:57:14 INFO - 2015-12-02 10:57:14,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41699/tests/dromaeo/cssquery-mootools.html) 10:57:15 INFO - 2015-12-02 10:57:15,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 144756736 10:57:15 INFO - 2015-12-02 10:57:15,580 DEBUG : BROWSER_OUTPUT: 11:00:17 INFO - 2015-12-02 11:00:17,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41699/tests/dromaeo/cssquery-prototype.html) 11:00:17 INFO - 2015-12-02 11:00:17,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 143937536 11:00:17 INFO - 2015-12-02 11:00:17,956 DEBUG : BROWSER_OUTPUT: 11:03:20 INFO - 2015-12-02 11:03:20,558 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41699/tests/dromaeo/cssquery-yui.html) 11:03:21 INFO - 2015-12-02 11:03:21,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 144928768 11:03:21 INFO - 2015-12-02 11:03:21,192 DEBUG : BROWSER_OUTPUT: 11:06:23 INFO - 2015-12-02 11:06:23,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/dromaeo/cssquery-yui.html (next: http://localhost:41699/tests/dromaeo/cssquery-dojo.html) 11:06:23 INFO - 2015-12-02 11:06:23,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 146792448 11:06:23 INFO - 2015-12-02 11:06:23,728 DEBUG : BROWSER_OUTPUT: 11:06:23 INFO - 2015-12-02 11:06:23,728 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:06:23 INFO - 2015-12-02 11:06:23,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:06:23 INFO - 2015-12-02 11:06:23,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:06:23 INFO - 2015-12-02 11:06:23,728 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:06:23 INFO - 2015-12-02 11:06:23,728 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2624.291441310846;2666.0802023301953;2706.215197592698;2715.86420678966;2717.904873329433;4539.341795439659;4638.698484598499;4670.859874203779;4671.229247174212;4679.04079663669;4568.063546972871;4628.884277893055;4709.152352576543;4805.303231031498;4807.495213002628;4296.5273819879785;4322.632576231016;4454.53227411122;4457.041736026754;4481.282994720846;4123.690723195772;4361.062371590107;4391.824327026915;4392.275274579691;4493.146302202587;4206.495220573551;4283.400323954649;4290.2706539888295;4311.741295522279;4329.307310830283;4337.219300525904;4339.284018137004;4351.412559304485;4365.388845561624;4387.583179597933;4193;4312.05134870328;4316.352547117926;4328.653707703376;4373.825046998117;4529.886752831173;4618.745968971705;4622.8150873965005;4658.813647454098;4666.4633567139535;5078.263651770472;5104.540591346759;5108.233764935252;5127.077126117298;5127.7948882044675;4875.780589873464;4953.6037117030555;5006.1489546776775;5065.392152941634;5165.147750621143;4645.74448405341;4696.201645720235;4713.740744259098;4741.810327586927;4776.47458779534;5128.410232823198;5129.461406552333;5138.640295179376;5139.614528910347;5160.587153027749;4785.521447855256;4862.975685121552;4899.436564795023;4990.975045124751;5006.6245031622775;5025.095482813129;5063.088644044107;5074.949250507448;5080.949190508048;5123.129068058439;4990.925136122961;5018.874528136753;5029.396472423333;5031.6729412588065;5049.116404629175;4774.570288674036;4887.853364399074;4889.877753056131;4933.802647894116;4981.252812078144;4161.479815023122;4180.47744031996;4182.2681030819485;4190.601892820177;4219.451471308772;3612.0608641753333;3668.449732540087;3700.0564855961557;3712.480252764615;3717.8141092945243;4290.141971605692;4360;4371.956280437155;4383.167198232326;4389.824407023747;5024.145895197825;5048.29323894655;5053.772580233898;5076.796928122908;5096.923546146811;4381.627561657231;4386.868393948187;4388.934165987449;4397.6921615487245;4428.202923473806;4304.053108316165;4413.337999300131;4425.800838962255;4515.616172625364;4568.885777855514;4797.304390863305;4805.207140821725;4820.590249828663;4829.637777166727;4830.178869592178;4903.8528844134735;5047.87380315495;5050.419201791841;5071.112555302881;5100.285959965534;4738.407699037621;4748.833790817304;4807.6394270429155;4830.516948305141;4831.0820944020525;4985.177445721561;5069.163588008085;5074.720890350918;5075.695458272516;5119.974400127976;4880.072786170616;4994;5102.4897510248675;5105.106606343801;5168.198929165835;4817.253325734517;4848.75756212195;4882.707037577615;4909.165441874961;4931.630127740362;4963.70217786934;4968.378952630921;4972.204447288416;4976.029674213493;4979.203327467588;4498.505164431845;4616.261398176276;4665.486796452456;4858.82994095205;4887.218045112765;4915.582175515121;4947;4950.059488697136;4964.528369804862;4992.850214493571;4825.6139508838505;4836.564709176191;4846.80612775485;4887.951120488749;4903.289023091703 11:06:23 INFO - 2015-12-02 11:06:23,729 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.8298081580531;571.848460158058;583.9357670656228;595.4343373794896;615.1971676961564;27478.175654730367;28142.57786133207;36272.45591316129;36857.63142368576;36911.81544092276;39107.60892391075;39199.21601567967;39606.405903911465;39610.207795844064;39742.20515589694;7828.060632724067;7912.446128770988;7938.920610793876;7953.801154971115;7957.522548647071;7817.179196184404;7915;7916.287534121928;7930.088039875402;7949.523028618272;7884.172161923001;7916.445848790559;7945.64244608994;7951.244631759973;7955.0453945526615;7920.089189743196;7927.445078844455;7937.563434011127;7976.6011699415085;7989.480683755537;7705.845883082307;7756.922430775677;7777.300042996101;7832.060152781646;7837.6864925402915;36432.817835910915;36593;36823.815880920694;36829;36907.815460922524;2895.4643390972738;2963.4369469800668;3115.283484798509;3254.8209848458328;3454.1191996040848;27468.58797118045;27980.160595182177;28177.85911070452;28222.294442638893;28324.150275491564;3222.5810644616286;3291.2857770149108;3300.7689461737687;3325.318309746496;3425.1779572902324;215583;216283;217721;217865;218129;49972.25041624378;51210.48789512057;54121;54565.1815222772;54568;65546;66627.66686166538;66959.66520167368;66964.33035669678;67061;14180.361883715257;14366.712665746627;14388.136711797326;14392;14393.92803035978;10691.946540267405;10768.892311076946;10778.838317425245;10803.189760767973;10864.891351086546;18932.905335473235;19305.903470482557;19330.903345483184;19442.222311107398;19514;7581.431392645573;7790.922090779133;7807.843843123106;7859.921400785919;7907.209279072162;766.52858492027;775.2751177648917;804.3846457460048;853.8078932240196;895.4850960697624;25483.36291592725;25634.871825640752;25661.61507577388;26033.219003429927;29508.852455737582;883.4346018548134;935.4995077633433;937.9108984646448;1012.367270455965;1053.2469284461495;13673.86326136726;13825;13831.446742130202;13843.515476958259;14032.789508157386;318542;321087;322001;322125;322821;45334.31998520025;45490;45922.77038614786;45940.86532212117;46150.30774538385;1134.6652737442473;1188.6671731915078;1192.6064398748392;1195.2290772451893;1207.7644859252537;25662.61506077373;26111.608325874746;26131.608025879246;26171.869140654177;26592;38174;39209;39236.41145382878;39283.80358098191;39334.80332598319;248300;249903;250090;250541;250564;24355.14756983497;24922.750772492043;28469.857650711612;28481.715182847907;28657;33604;33652;34120;34375.48436773501;34542.13644658803;30475.695243047285;31149.844250778602;31452.370952581277;31529.684703152674;31563.684363156073;31635.84182079075;31731.36537269288;31733;32111.197220069684;32229.51655725119;32152.839235803673;32207.35585288328;32325.35349292954;32615.836920815244;32681;27952.860235698692;28953.710462895942;33409;34790.30419391648;34982.65017349794;24073.398165046015;24400.51198975975;24581.754182458662;24668.87665561661;24809.751902480744 11:06:23 INFO - 2015-12-02 11:06:23,729 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.71883617761074;335.34607515345067;337.6792047554823;338.31153602419084;339.24517947566665;15088.321025553849;15237.16195609241;15381.769273460906;15659.373625054985;15888.364465421399;9568;9754.414735115897;9817.410955342684;10213.642522511713;10217.693469195936;4520.90958180837;4631.791569379386;4636.188666983281;4641.559051890065;4645.349651048856;4596.655250856183;4904.779284932187;4996.850094497171;5015;5021.271915572258;4758.405199350082;4934.037862616791;4942.579880710126;5001.399832020163;5015.7492125393765;4880.194767863299;4926.236433352836;4926.704397736147;4937.876553086166;4962.503749625044;4997.325361076245;4998.550130488274;5001.699898006132;5003.799848006075;5005.524475174852;15876.967997080268;17941.64116717658;17956.730649040273;18726.063696815105;18772.249110035584;1811.0401487211798;1890.5840715042807;1908.6182763447366;1917.7890432052463;1939.2727727102338;8319.417640765088;8650.35122365825;8934.240589549896;8976.775580610538;11909.22590031645;1723.2159367487764;1767.6199617082261;1773.2640954004073;1783.3134243316288;1800.5768644368563;56587.43412565863;56715;57246.42753572453;57808.421915780724;58034.70982645102;9911.65309214174;9915.603375865028;9932.702018939442;9973.30186886911;9977.501124943723;12321.691957701129;12330.075244356709;12420.192687475466;12458.81311780324;12501.24992500453;7236.710531578678;7267.164276108315;7372.299631534996;7374.299441553044;7433;7273.490855640161;7276.927230727731;7313.451491138186;7357.742479013209;7369.926300737031;4095.9385609215888;4172.248995180897;4234.280172370704;4234.978825105854;4239.4737894358;1670.1148391352604;1734.531676447352;1837.366108692499;1840.7083181439193;1854.870159088878;353.7682817754375;355.96440355964194;367.59197291007496;372.7148731220618;788.731831177391;9456.243500519942;15223.31495082724;16004.439844605384;16251.756223656655;16794.748078778826;827.71443851871;844.1980118887082;851.131845517581;874.3748220022715;878.1262643669589;8407.075221725605;8450.830983380298;9058.592363343665;9092.318076144184;9253.306002049872;503048;503814;506316;515560;516062;68833.65583172052;69863;70260;71259;71506;1082.0640146273574;1082.1937656445998;1098.8461615373853;1109.8446217529552;1110.3116068037707;14025.438982440588;14032.438702452197;14093.718125637635;14107.788383174466;14292.28538573088;32084.35831283408;32109.51835722419;34100.488492672135;34587.30825383428;35717.846957700436;41166.79416602898;41315.1736965253;41631.58368416277;42158;43697.34453983129;8089.2315230053055;8532.616032278438;8651.783705407415;8679.392442528962;8731.65073397057;10160.034796694303;10198.59205631796;11460.426978651201;15769.921150394175;15941.920290398937;13047;13525.59423217305;13588.184708917497;13887.861121388656;13901.0964287321;13110.672233194246;13338.599842004756;13391.933040334736;13870.930645346709;13872.098313609584;13853.37659805291;14586.635334116732;14607;14620.342084606005;14790.03864748788;8790.780230494032;8932.642694292155;8993.685221017233;9000.369974102012;9044.592993315186;9112.772180695536;10593.364398136137;14162.575122746333;14227.857721422653;14303.713925721635 11:06:23 INFO - 2015-12-02 11:06:23,729 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1407.4933024111317;1480.5484327280176;1568.6078480379906;1578.7158311503938;1667.9249433775478;7041.647917604118;7099.006139140512;7411.88882166768;7412.555246685202;7428.33145016949;7435.962820185905;7469.215732348107;7553.206913274096;7556.433267504945;7576.5075270107545;2061.0622166914054;2091.215794077221;2097.2345094040716;2100.6323893318686;2104.831613470926;2125.298651445027;2128.0317455557683;2146.6994620753107;2147.6778483227486;2154.8707077575395;1986.6721990871488;2046.8362530997485;2062.597793430282;2067.9896600516977;2075.730155079845;2079.979200208001;2101.495641046153;2110.3457928042358;2111.9049642766036;2113.704081428601;2048.283100914683;2083.114676262582;2086.603545326383;2093.2255065625664;2103.9579208415744;7167.068281123473;7209.89185162223;7218.530795498328;7248.8550228995655;7278.272172782679;4190.580941905816;4251.829926802924;4265.232258193524;4287.164003019412;4295.78521073945;2729.440464704731;2747.5329194037063;2748.491529067109;2761.6962134165224;2795.804293699442;863.1066845814552;868.6091258933442;871.0766587417357;871.1462766488813;908.7546362482093;9388.62445502179;9395.295352848496;9437.622495100188;9453.52732363386;9507.286953478517;3660.4692319613505;3718.4050551911564;3741.9438708419398;3763.4354846773203;3763.8118094095184;7601.429892758065;7634.923650763532;7640;7666.8849967250535;7667.11828139771;4042.7372220805555;4082.795860206978;4108.50697916246;4117.526484454326;4119.97940010298;3808.3906574947873;3827.2154208387215;3832.0419895026243;3836.175222327213;3846.9230615387537;3032.9233122241726;3051.92370190747;3077.815331080142;3090.196548897303;3101.968980310168;908.5321059654283;911.9908800912038;915.8992510823804;916.3493919317226;916.5005072235648;893.2809088683672;897.3763234552055;899.9460032398077;905.5698543192062;1200.2378489658954;6792.728290868409;6820.624865632339;6838.111045564145;6842.076319696876;6904.654767261617;981.1856159387834;994.0705440413092;996.3872218585662;1064.5316060933164;1079.4117206122683;5503.642263252956;5523.8066667666435;5528.695921724263;5540.806071787468;5548.69482178484;8290.922180116546;8429.072801991775;8576.185262400062;8588.613512391958;8595.699150529827;8624.74125776215;8671;8696.130386961253;8773.385862989657;8810.383273170817;6391.648459334781;6408.775692850728;6483.124778154889;6507.934920650733;6551.770688025991;6473.64394958263;6522.641254731036;6547.574407663486;6549.345065493412;6552.3775241352;7617.847643046997;7802.453828231969;7812.57030863308;7819.804504887424;7899.09160446556;7952.244536768998;8046.597670116354;8070.435069545076;8152.592370381576;8158.592070396575;6581.407673309425;6624.6025238485845;6718.496112791658;6735.225449073419;6742.831429214309;6739.797806065826;6841.042254084333;6856.211535673262;6859.176898772179;6878.58728476293;6067.453929146398;6111.602745821508;6164.47601953839;6490.610563366213;6538.574992625464;6390;6445.774397896051;6453.580517266362;6552.57408268461;6589.4069533742195;6611;6679.265280819009;6693.799186024427;6700.664966751546;6710.563813352116;5927.792527261525;5988.251468566429;6002.249718785152;6079.483243924316;6109.1141784440115;6229.283632382334;6230.844228894314;6245.8750824982335;6246.031865060741;6263.185785847811 11:06:23 INFO - 2015-12-02 11:06:23,729 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.495188276165;294.305439163574;298.1235168604303;306.32455435764126;308.434023566755;5545.722713864306;5572.136318870582;5618.634788738735;5689.943100568993;5711.371749107595;5562.360328562207;5609.074502707049;5631.4087020862835;5631.746571404286;5632.831015069544;4146.60607242313;4286.5284818669925;4286.699931004831;4291.699581029329;4294.420253265808;4231.322988321869;4276.893077673068;4293.65650747941;4294.9570504295025;4297.419848320468;4232.15356928614;4236.258654735424;4242.596953289432;4243.363495475673;4243.702940794145;4232.809523571446;4243.448351714288;4243.872683819491;4250.659947204216;4254.787260636956;3698.7595806272507;3699.9445008324897;3701.777893326409;3702.4631428442726;3708.8887333380044;5200.479952004769;5228.08508511009;5316.601254905859;5378.327709036371;5381.704006279653;4880.170371036932;4883.633727470454;4884.975575122137;4889.193283108283;4897.534734200245;5858.033424484955;5858.443447872445;5860.062390017577;5862.443067908542;5869.471747542699;3860.247251785903;3970.8411663533425;3976.1451287973223;4000.2599519089063;4020.135670830756;6051.969740151271;6136.969315153396;6141.999999999955;6144.477719393857;6161.7227224775;4071.776052317151;4096.795160242035;4101.712880098365;4106.67146628275;4107.424960505532;4151.750894946253;4169.958300416957;4170.4995400552125;4170.958290417057;4174.3112386456505;4729.125111854318;4822.807087716522;4823.397075365579;4830.275458681155;4838.879028024327;5798.536117110621;5802.506786923159;5810.389909059488;5811.4479124483105;5818.44724751148;1463.6706740983193;1486.5763257471785;1487;1488.694817562397;1489.143742348154;981.1954197557934;982.8083523712808;987.7975015121883;1000.5447521377756;1003.1573478278282;5098.1842905135745;5101.821436249714;5107.463716309809;5112.642115051911;5112.769925353368;6033.095035744674;6048.909266361008;6055.152278680988;6057.757689692363;6067.696615169224;5093.923591146136;5095.847124586268;5106.617003724736;5108.56577190943;5124.9743751281;3188.3304506053523;3265.755068369882;3269.2807582331848;3289.967100329014;3294.4893541501106;5650.208970744099;5747.683877386784;5759.366469688331;5761.279840019997;5774.047282198474;6258.968705156445;6263.498920086382;6294.181756371642;6329.493640508748;6343.936560634427;5820.417958204146;5821.941780582225;5825.271841019872;5830.921279563295;5838.94161058384;6107.480864126599;6123.050927106306;6130.969345153246;6147.538934579835;6148.016317389196;5766.106253530709;5916.437938395846;5952.494038006645;5982.4316689914385;5989.431004054608;5758.395368486416;5785.595008349375;5800;5803;5817.680027598522;4191.664666826708;4241.63946064588;4241.87274381769;4250.702450828412;4252.107057517832;5888.94111058901;6037.879242415215;6041.335453100243;6042.335343112166;6051.062085376773;5820.5925585210325;5822.010258256191;5828.329742079545;5841.532677385884;5842.620229685227;5791.189233507396;5799.652020878761;5809.9419005809405;5810.535157187331;5843.545710801389;5536.446355364431;5664.830055098354;5672.688002159755;5675.772969081356;5707.771689132388;5843.386444423274;5847.8538036547725;5851.180834683063;5854.356020837619;5862.384449632727;5625.212470254086;5632.605717599728;5673.8297851064535;5682.744276507485;5685.829425117253 11:06:23 INFO - 2015-12-02 11:06:23,730 DEBUG : BROWSER_OUTPUT: |5;yui.html;551.9558435325174;618.6721037849939;670.2191946382463;670.8423520472688;675.5912672832933;12030.51877924882;12455.128141030109;12456.564020259293;12461.875381246196;12463.314517701523;13706.451741930336;14005;14016;14028.43886244549;14058;630.5050535329767;638.0270088115637;818.7461886815091;831.2560258568577;833.3666413525704;804.9074356448996;807.7778610881995;812.4475356757403;814.7107776739261;815.3436483630675;846.1580727176469;851.93610479214;852.5353682243192;853.6372041882206;856.6273670953155;846.2975730143966;852.6972924611766;854.1970547685219;854.2653318146389;857.1514200941086;621.937806219379;627.5387590121258;628.2335550628226;628.7736414890636;629.2197674883158;12040.39798010096;12057.758844823142;12120.696982575419;12190.329531875743;12199.268043917393;10902.781944361068;10966.945165274123;11106.44467776608;11178.217524773268;11499.77000459986;9415.246780257632;9519.143277105093;9521.90478095217;9608.327417080807;9646.614135434575;3355.647656996029;3361.210115622827;3368.3936891359544;3388.8983330500123;3396.473546600256;43071.35392969108;43230.13539729219;43339.349909751065;43345.56654433478;43627.56372436267;9521;9575.664851730156;9632;9702.90297097034;9759.804803903882;16350.710900473943;16368.590785230464;16370.181490925406;16403;16427.58931026734;6258.249010118724;6305.653189074553;6327.651979141099;6438.420542151229;6558;3585.2112535242204;3620.0768803954825;3627.3108109459117;3637.2907283080076;3643.3441980443245;2771.8198317109322;2772.3900741836765;2791.3300807806386;2792.720727927191;2803.649543807024;510.5354127743735;513.3403576404303;517.5936889541691;518.8988147311313;521.48633595908;553.396797490729;595.6574969392617;599.6342231238941;601.3595520770366;638.7125793392992;7403.703851845974;7587.696492140363;7636;7647.885281720779;7691.5769632670745;575.9164921086419;578.5574035862569;579.0214537431727;590.9556783241188;591.7662523303271;3528;3606.2787442511603;3652.5982141964364;3695.611960744137;3776.6223377662013;50624.74687626538;51390;51716.74141629268;51850.74074629678;51932;45141.322880156826;45532.08935821265;46088.308675369895;46408;46463;42358.78820605877;42966.57033429626;43233.78383108064;43432.13135737267;43605.127897441875;7389.113306403266;7507.737229196952;7519.699212031676;7537.434692398202;7601.581912994839;31863.84068079645;31886.6811331893;32532.02403927886;32873.342533149684;33202.667973320924;37041.44437833488;37055.44416833696;39615;40573.1885362297;41247.381289281286;8829.16122968317;9033.954830225806;9418.62325506972;9419.387739796892;9421.81156376855;10253.33353332031;11633.59282425111;11780.882191177978;11890.76218475643;11933.403329833647;10821.134309255083;10855.837162442413;10962.287451315959;11097.167712421762;11126.332420054823;10763.085137763064;10819.18856085781;11012;11082.889171108185;11197.552097915992;11035.282706624364;11094.722631934266;11121.833172502256;11125.276857004268;11391.943040285078;9130.132637399702;9135.177833994972;9142.817143657223;9464.242860571276;9464.337496375188;9137.680181193626;9183.77040573991;9190.21883139914;9296.302777291865;9311.394759340621 11:06:23 INFO - 2015-12-02 11:06:23,730 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:06:23 INFO - 2015-12-02 11:06:23,730 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:06:23 INFO - 2015-12-02 11:06:23,730 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,335 11:06:23 INFO - 2015-12-02 11:06:23,730 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:06:23 INFO - 2015-12-02 11:06:23,730 DEBUG : BROWSER_OUTPUT: __startTimestamp1449083183723__endTimestamp 11:06:23 INFO - 2015-12-02 11:06:23,731 DEBUG : BROWSER_OUTPUT: 11:06:23 INFO - 2015-12-02 11:06:23,731 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:06:23 INFO - 2015-12-02 11:06:23,731 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:06:23 INFO - 2015-12-02 11:06:23,731 DEBUG : BROWSER_OUTPUT: 11:06:23 INFO - 2015-12-02 11:06:23,731 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4650.98 Median:4805.30 stddev:488.84 (10.2%) stddev-sans-first:463.77 11:06:23 INFO - 2015-12-02 11:06:23,732 DEBUG : BROWSER_OUTPUT: Values: 2624.3 2666.1 2706.2 2715.9 2717.9 4539.3 4638.7 4670.9 4671.2 4679.0 4568.1 4628.9 4709.2 4805.3 4807.5 4296.5 4322.6 4454.5 4457.0 4481.3 4123.7 4361.1 4391.8 4392.3 4493.1 4206.5 4283.4 4290.3 4311.7 4329.3 4337.2 4339.3 4351.4 4365.4 4387.6 4193.0 4312.1 4316.4 4328.7 4373.8 4529.9 4618.7 4622.8 4658.8 4666.5 5078.3 5104.5 5108.2 5127.1 5127.8 4875.8 4953.6 5006.1 5065.4 5165.1 4645.7 4696.2 4713.7 4741.8 4776.5 5128.4 5129.5 5138.6 5139.6 5160.6 4785.5 4863.0 4899.4 4991.0 5006.6 5025.1 5063.1 5074.9 5080.9 5123.1 4990.9 5018.9 5029.4 5031.7 5049.1 4774.6 4887.9 4889.9 4933.8 4981.3 4161.5 4180.5 4182.3 4190.6 4219.5 3612.1 3668.4 3700.1 3712.5 3717.8 4290.1 4360.0 4372.0 4383.2 4389.8 5024.1 5048.3 5053.8 5076.8 5096.9 4381.6 4386.9 4388.9 4397.7 4428.2 4304.1 4413.3 4425.8 4515.6 4568.9 4797.3 4805.2 4820.6 4829.6 4830.2 4903.9 5047.9 5050.4 5071.1 5100.3 4738.4 4748.8 4807.6 4830.5 4831.1 4985.2 5069.2 5074.7 5075.7 5120.0 4880.1 4994.0 5102.5 5105.1 5168.2 4817.3 4848.8 4882.7 4909.2 4931.6 4963.7 4968.4 4972.2 4976.0 4979.2 4498.5 4616.3 4665.5 4858.8 4887.2 4915.6 4947.0 4950.1 4964.5 4992.9 4825.6 4836.6 4846.8 4888.0 4903.3 11:06:23 INFO - 2015-12-02 11:06:23,732 DEBUG : BROWSER_OUTPUT: 11:06:23 INFO - 2015-12-02 11:06:23,732 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41978.06 Median:17986.14 stddev:69775.07 (387.9%) stddev-sans-first:69901.48 11:06:23 INFO - 2015-12-02 11:06:23,732 DEBUG : BROWSER_OUTPUT: Values: 554.8 571.8 583.9 595.4 615.2 27478.2 28142.6 36272.5 36857.6 36911.8 39107.6 39199.2 39606.4 39610.2 39742.2 7828.1 7912.4 7938.9 7953.8 7957.5 7817.2 7915.0 7916.3 7930.1 7949.5 7884.2 7916.4 7945.6 7951.2 7955.0 7920.1 7927.4 7937.6 7976.6 7989.5 7705.8 7756.9 7777.3 7832.1 7837.7 36432.8 36593.0 36823.8 36829.0 36907.8 2895.5 2963.4 3115.3 3254.8 3454.1 27468.6 27980.2 28177.9 28222.3 28324.2 3222.6 3291.3 3300.8 3325.3 3425.2 215583.0 216283.0 217721.0 217865.0 218129.0 49972.3 51210.5 54121.0 54565.2 54568.0 65546.0 66627.7 66959.7 66964.3 67061.0 14180.4 14366.7 14388.1 14392.0 14393.9 10691.9 10768.9 10778.8 10803.2 10864.9 18932.9 19305.9 19330.9 19442.2 19514.0 7581.4 7790.9 7807.8 7859.9 7907.2 766.5 775.3 804.4 853.8 895.5 25483.4 25634.9 25661.6 26033.2 29508.9 883.4 935.5 937.9 1012.4 1053.2 13673.9 13825.0 13831.4 13843.5 14032.8 318542.0 321087.0 322001.0 322125.0 322821.0 45334.3 45490.0 45922.8 45940.9 46150.3 1134.7 1188.7 1192.6 1195.2 1207.8 25662.6 26111.6 26131.6 26171.9 26592.0 38174.0 39209.0 39236.4 39283.8 39334.8 248300.0 249903.0 250090.0 250541.0 250564.0 24355.1 24922.8 28469.9 28481.7 28657.0 33604.0 33652.0 34120.0 34375.5 34542.1 30475.7 31149.8 31452.4 31529.7 31563.7 31635.8 31731.4 31733.0 32111.2 32229.5 32152.8 32207.4 32325.4 32615.8 32681.0 27952.9 28953.7 33409.0 34790.3 34982.7 24073.4 24400.5 24581.8 24668.9 24809.8 11:06:23 INFO - 2015-12-02 11:06:23,732 DEBUG : BROWSER_OUTPUT: 11:06:23 INFO - 2015-12-02 11:06:23,733 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26683.99 Median:23196.14 stddev:83128.51 (358.4%) stddev-sans-first:83338.16 11:06:23 INFO - 2015-12-02 11:06:23,733 DEBUG : BROWSER_OUTPUT: Values: 334.7 335.3 337.7 338.3 339.2 15088.3 15237.2 15381.8 15659.4 15888.4 9568.0 9754.4 9817.4 10213.6 10217.7 4520.9 4631.8 4636.2 4641.6 4645.3 4596.7 4904.8 4996.9 5015.0 5021.3 4758.4 4934.0 4942.6 5001.4 5015.7 4880.2 4926.2 4926.7 4937.9 4962.5 4997.3 4998.6 5001.7 5003.8 5005.5 15877.0 17941.6 17956.7 18726.1 18772.2 1811.0 1890.6 1908.6 1917.8 1939.3 8319.4 8650.4 8934.2 8976.8 11909.2 1723.2 1767.6 1773.3 1783.3 1800.6 56587.4 56715.0 57246.4 57808.4 58034.7 9911.7 9915.6 9932.7 9973.3 9977.5 12321.7 12330.1 12420.2 12458.8 12501.2 7236.7 7267.2 7372.3 7374.3 7433.0 7273.5 7276.9 7313.5 7357.7 7369.9 4095.9 4172.2 4234.3 4235.0 4239.5 1670.1 1734.5 1837.4 1840.7 1854.9 353.8 356.0 367.6 372.7 788.7 9456.2 15223.3 16004.4 16251.8 16794.7 827.7 844.2 851.1 874.4 878.1 8407.1 8450.8 9058.6 9092.3 9253.3 503048.0 503814.0 506316.0 515560.0 516062.0 68833.7 69863.0 70260.0 71259.0 71506.0 1082.1 1082.2 1098.8 1109.8 1110.3 14025.4 14032.4 14093.7 14107.8 14292.3 32084.4 32109.5 34100.5 34587.3 35717.8 41166.8 41315.2 41631.6 42158.0 43697.3 8089.2 8532.6 8651.8 8679.4 8731.7 10160.0 10198.6 11460.4 15769.9 15941.9 13047.0 13525.6 13588.2 13887.9 13901.1 13110.7 13338.6 13391.9 13870.9 13872.1 13853.4 14586.6 14607.0 14620.3 14790.0 8790.8 8932.6 8993.7 9000.4 9044.6 9112.8 10593.4 14162.6 14227.9 14303.7 11:06:23 INFO - 2015-12-02 11:06:23,733 DEBUG : BROWSER_OUTPUT: 11:06:23 INFO - 2015-12-02 11:06:23,733 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5007.87 Median:6530.61 stddev:2607.15 (39.9%) stddev-sans-first:2600.42 11:06:23 INFO - 2015-12-02 11:06:23,734 DEBUG : BROWSER_OUTPUT: Values: 1407.5 1480.5 1568.6 1578.7 1667.9 7041.6 7099.0 7411.9 7412.6 7428.3 7436.0 7469.2 7553.2 7556.4 7576.5 2061.1 2091.2 2097.2 2100.6 2104.8 2125.3 2128.0 2146.7 2147.7 2154.9 1986.7 2046.8 2062.6 2068.0 2075.7 2080.0 2101.5 2110.3 2111.9 2113.7 2048.3 2083.1 2086.6 2093.2 2104.0 7167.1 7209.9 7218.5 7248.9 7278.3 4190.6 4251.8 4265.2 4287.2 4295.8 2729.4 2747.5 2748.5 2761.7 2795.8 863.1 868.6 871.1 871.1 908.8 9388.6 9395.3 9437.6 9453.5 9507.3 3660.5 3718.4 3741.9 3763.4 3763.8 7601.4 7634.9 7640.0 7666.9 7667.1 4042.7 4082.8 4108.5 4117.5 4120.0 3808.4 3827.2 3832.0 3836.2 3846.9 3032.9 3051.9 3077.8 3090.2 3102.0 908.5 912.0 915.9 916.3 916.5 893.3 897.4 899.9 905.6 1200.2 6792.7 6820.6 6838.1 6842.1 6904.7 981.2 994.1 996.4 1064.5 1079.4 5503.6 5523.8 5528.7 5540.8 5548.7 8290.9 8429.1 8576.2 8588.6 8595.7 8624.7 8671.0 8696.1 8773.4 8810.4 6391.6 6408.8 6483.1 6507.9 6551.8 6473.6 6522.6 6547.6 6549.3 6552.4 7617.8 7802.5 7812.6 7819.8 7899.1 7952.2 8046.6 8070.4 8152.6 8158.6 6581.4 6624.6 6718.5 6735.2 6742.8 6739.8 6841.0 6856.2 6859.2 6878.6 6067.5 6111.6 6164.5 6490.6 6538.6 6390.0 6445.8 6453.6 6552.6 6589.4 6611.0 6679.3 6693.8 6700.7 6710.6 5927.8 5988.3 6002.2 6079.5 6109.1 6229.3 6230.8 6245.9 6246.0 6263.2 11:06:23 INFO - 2015-12-02 11:06:23,734 DEBUG : BROWSER_OUTPUT: 11:06:23 INFO - 2015-12-02 11:06:23,734 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4834.90 Median:5590.61 stddev:1437.84 (25.7%) stddev-sans-first:1400.89 11:06:23 INFO - 2015-12-02 11:06:23,735 DEBUG : BROWSER_OUTPUT: Values: 293.5 294.3 298.1 306.3 308.4 5545.7 5572.1 5618.6 5689.9 5711.4 5562.4 5609.1 5631.4 5631.7 5632.8 4146.6 4286.5 4286.7 4291.7 4294.4 4231.3 4276.9 4293.7 4295.0 4297.4 4232.2 4236.3 4242.6 4243.4 4243.7 4232.8 4243.4 4243.9 4250.7 4254.8 3698.8 3699.9 3701.8 3702.5 3708.9 5200.5 5228.1 5316.6 5378.3 5381.7 4880.2 4883.6 4885.0 4889.2 4897.5 5858.0 5858.4 5860.1 5862.4 5869.5 3860.2 3970.8 3976.1 4000.3 4020.1 6052.0 6137.0 6142.0 6144.5 6161.7 4071.8 4096.8 4101.7 4106.7 4107.4 4151.8 4170.0 4170.5 4171.0 4174.3 4729.1 4822.8 4823.4 4830.3 4838.9 5798.5 5802.5 5810.4 5811.4 5818.4 1463.7 1486.6 1487.0 1488.7 1489.1 981.2 982.8 987.8 1000.5 1003.2 5098.2 5101.8 5107.5 5112.6 5112.8 6033.1 6048.9 6055.2 6057.8 6067.7 5093.9 5095.8 5106.6 5108.6 5125.0 3188.3 3265.8 3269.3 3290.0 3294.5 5650.2 5747.7 5759.4 5761.3 5774.0 6259.0 6263.5 6294.2 6329.5 6343.9 5820.4 5821.9 5825.3 5830.9 5838.9 6107.5 6123.1 6131.0 6147.5 6148.0 5766.1 5916.4 5952.5 5982.4 5989.4 5758.4 5785.6 5800.0 5803.0 5817.7 4191.7 4241.6 4241.9 4250.7 4252.1 5888.9 6037.9 6041.3 6042.3 6051.1 5820.6 5822.0 5828.3 5841.5 5842.6 5791.2 5799.7 5809.9 5810.5 5843.5 5536.4 5664.8 5672.7 5675.8 5707.8 5843.4 5847.9 5851.2 5854.4 5862.4 5625.2 5632.6 5673.8 5682.7 5685.8 11:06:23 INFO - 2015-12-02 11:06:23,736 DEBUG : BROWSER_OUTPUT: 11:06:23 INFO - 2015-12-02 11:06:23,736 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12612.89 Median:25567.64 stddev:14366.50 (56.2%) stddev-sans-first:14378.25 11:06:23 INFO - 2015-12-02 11:06:23,737 DEBUG : BROWSER_OUTPUT: Values: 552.0 618.7 670.2 670.8 675.6 12030.5 12455.1 12456.6 12461.9 12463.3 13706.5 14005.0 14016.0 14028.4 14058.0 630.5 638.0 818.7 831.3 833.4 804.9 807.8 812.4 814.7 815.3 846.2 851.9 852.5 853.6 856.6 846.3 852.7 854.2 854.3 857.2 621.9 627.5 628.2 628.8 629.2 12040.4 12057.8 12120.7 12190.3 12199.3 10902.8 10966.9 11106.4 11178.2 11499.8 9415.2 9519.1 9521.9 9608.3 9646.6 3355.6 3361.2 3368.4 3388.9 3396.5 43071.4 43230.1 43339.3 43345.6 43627.6 9521.0 9575.7 9632.0 9702.9 9759.8 16350.7 16368.6 16370.2 16403.0 16427.6 6258.2 6305.7 6327.7 6438.4 6558.0 3585.2 3620.1 3627.3 3637.3 3643.3 2771.8 2772.4 2791.3 2792.7 2803.6 510.5 513.3 517.6 518.9 521.5 553.4 595.7 599.6 601.4 638.7 7403.7 7587.7 7636.0 7647.9 7691.6 575.9 578.6 579.0 591.0 591.8 3528.0 3606.3 3652.6 3695.6 3776.6 50624.7 51390.0 51716.7 51850.7 51932.0 45141.3 45532.1 46088.3 46408.0 46463.0 42358.8 42966.6 43233.8 43432.1 43605.1 7389.1 7507.7 7519.7 7537.4 7601.6 31863.8 31886.7 32532.0 32873.3 33202.7 37041.4 37055.4 39615.0 40573.2 41247.4 8829.2 9034.0 9418.6 9419.4 9421.8 10253.3 11633.6 11780.9 11890.8 11933.4 10821.1 10855.8 10962.3 11097.2 11126.3 10763.1 10819.2 11012.0 11082.9 11197.6 11035.3 11094.7 11121.8 11125.3 11391.9 9130.1 9135.2 9142.8 9464.2 9464.3 9137.7 9183.8 9190.2 9296.3 9311.4 11:06:23 INFO - 2015-12-02 11:06:23,737 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:06:23 INFO - 2015-12-02 11:06:23,737 DEBUG : BROWSER_OUTPUT: 11:06:24 INFO - 2015-12-02 11:06:24,453 INFO : Browser exited with error code: 0 11:06:24 INFO - 2015-12-02 11:06:24,475 INFO : Completed test dromaeo_css (00:18:34) 11:06:24 INFO - 2015-12-02 11:06:24,475 INFO : Starting test kraken 11:06:24 INFO - 2015-12-02 11:06:24,475 DEBUG : operating with platform_type : linux_ 11:06:24 INFO - 2015-12-02 11:06:24,475 INFO : Initialising browser for kraken test... 11:06:24 INFO - 2015-12-02 11:06:24,481 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXyDMy3/profile http://localhost:41699/getInfo.html 11:06:29 INFO - 2015-12-02 11:06:29,316 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:06:29 INFO - 2015-12-02 11:06:29,316 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:06:29 INFO - 2015-12-02 11:06:29,316 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:06:29 INFO - 2015-12-02 11:06:29,316 DEBUG : BROWSER_OUTPUT: __metrics 11:06:29 INFO - 2015-12-02 11:06:29,453 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:06:30 INFO - 2015-12-02 11:06:30,341 INFO : Browser initialized. 11:06:30 INFO - 2015-12-02 11:06:30,342 INFO : Running cycle 1/1 for kraken test... 11:06:30 INFO - 2015-12-02 11:06:30,342 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXyDMy3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:06:42 INFO - 2015-12-02 11:06:42,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 142897152 11:06:42 INFO - 2015-12-02 11:06:42,390 DEBUG : BROWSER_OUTPUT: 11:06:44 INFO - 2015-12-02 11:06:44,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41699/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:45 INFO - 2015-12-02 11:06:45,556 DEBUG : BROWSER_OUTPUT: RSS: Main: 145264640 11:06:45 INFO - 2015-12-02 11:06:45,556 DEBUG : BROWSER_OUTPUT: 11:06:48 INFO - 2015-12-02 11:06:48,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41699/tests/kraken/driver.html?testName=audio-dft) 11:06:48 INFO - 2015-12-02 11:06:48,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 145162240 11:06:48 INFO - 2015-12-02 11:06:48,881 DEBUG : BROWSER_OUTPUT: 11:06:51 INFO - 2015-12-02 11:06:51,794 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41699/tests/kraken/driver.html?testName=audio-fft) 11:06:52 INFO - 2015-12-02 11:06:52,384 DEBUG : BROWSER_OUTPUT: RSS: Main: 139010048 11:06:52 INFO - 2015-12-02 11:06:52,384 DEBUG : BROWSER_OUTPUT: 11:06:54 INFO - 2015-12-02 11:06:54,536 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41699/tests/kraken/driver.html?testName=audio-oscillator) 11:06:55 INFO - 2015-12-02 11:06:55,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 139706368 11:06:55 INFO - 2015-12-02 11:06:55,159 DEBUG : BROWSER_OUTPUT: 11:06:57 INFO - 2015-12-02 11:06:57,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41699/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:06:58 INFO - 2015-12-02 11:06:58,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 141066240 11:06:58 INFO - 2015-12-02 11:06:58,030 DEBUG : BROWSER_OUTPUT: 11:07:01 INFO - 2015-12-02 11:07:01,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41699/tests/kraken/driver.html?testName=imaging-darkroom) 11:07:01 INFO - 2015-12-02 11:07:01,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 141910016 11:07:01 INFO - 2015-12-02 11:07:01,682 DEBUG : BROWSER_OUTPUT: 11:07:05 INFO - 2015-12-02 11:07:05,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41699/tests/kraken/driver.html?testName=imaging-desaturate) 11:07:05 INFO - 2015-12-02 11:07:05,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 137216000 11:07:05 INFO - 2015-12-02 11:07:05,758 DEBUG : BROWSER_OUTPUT: 11:07:08 INFO - 2015-12-02 11:07:08,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41699/tests/kraken/driver.html?testName=json-parse-financial) 11:07:09 INFO - 2015-12-02 11:07:09,263 DEBUG : BROWSER_OUTPUT: RSS: Main: 137474048 11:07:09 INFO - 2015-12-02 11:07:09,263 DEBUG : BROWSER_OUTPUT: 11:07:11 INFO - 2015-12-02 11:07:11,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41699/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:07:11 INFO - 2015-12-02 11:07:11,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 140423168 11:07:11 INFO - 2015-12-02 11:07:11,608 DEBUG : BROWSER_OUTPUT: 11:07:13 INFO - 2015-12-02 11:07:13,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41699/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:07:14 INFO - 2015-12-02 11:07:14,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 141168640 11:07:14 INFO - 2015-12-02 11:07:14,125 DEBUG : BROWSER_OUTPUT: 11:07:16 INFO - 2015-12-02 11:07:16,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41699/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:07:16 INFO - 2015-12-02 11:07:16,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 141201408 11:07:16 INFO - 2015-12-02 11:07:16,880 DEBUG : BROWSER_OUTPUT: 11:07:19 INFO - 2015-12-02 11:07:19,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:07:20 INFO - 2015-12-02 11:07:20,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 141135872 11:07:20 INFO - 2015-12-02 11:07:20,017 DEBUG : BROWSER_OUTPUT: 11:07:22 INFO - 2015-12-02 11:07:22,583 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:07:23 INFO - 2015-12-02 11:07:23,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 140480512 11:07:23 INFO - 2015-12-02 11:07:23,173 DEBUG : BROWSER_OUTPUT: 11:07:24 INFO - 2015-12-02 11:07:24,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41699/tests/kraken/driver.html?testName=ai-astar) 11:07:25 INFO - 2015-12-02 11:07:25,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 140619776 11:07:25 INFO - 2015-12-02 11:07:25,177 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,180 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:07:25 INFO - 2015-12-02 11:07:25,181 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:07:25 INFO - 2015-12-02 11:07:25,181 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:07:25 INFO - 2015-12-02 11:07:25,182 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:07:25 INFO - 2015-12-02 11:07:25,182 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;107;111;110;112;123;111;110;112;111 11:07:25 INFO - 2015-12-02 11:07:25,182 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;129;153;174;137;153;152;132;178;131 11:07:25 INFO - 2015-12-02 11:07:25,182 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;168;163;162;164;165;170;165;165;162 11:07:25 INFO - 2015-12-02 11:07:25,183 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;72;72;73;73;137;73;72;73 11:07:25 INFO - 2015-12-02 11:07:25,183 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;138;95;93;94;139;94;94;136 11:07:25 INFO - 2015-12-02 11:07:25,183 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;109;110;110;110;110;110;110 11:07:25 INFO - 2015-12-02 11:07:25,183 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;147;148;147;148;148;148;148;148 11:07:25 INFO - 2015-12-02 11:07:25,183 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;98;96;96;96;96;96;96;96;96 11:07:25 INFO - 2015-12-02 11:07:25,183 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;73;73;71;72;72;71;71 11:07:25 INFO - 2015-12-02 11:07:25,183 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;68;69;70;70;70;70;70;70;70 11:07:25 INFO - 2015-12-02 11:07:25,183 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;83;84;84;92;84;82;83;84 11:07:25 INFO - 2015-12-02 11:07:25,184 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;126;127;114;124;129;130;122;117;129 11:07:25 INFO - 2015-12-02 11:07:25,184 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;148;148;135;148;150;140;146;145;147 11:07:25 INFO - 2015-12-02 11:07:25,184 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;68;69;69;70;68;69;68;70;70 11:07:25 INFO - 2015-12-02 11:07:25,184 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:07:25 INFO - 2015-12-02 11:07:25,184 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:07:25 INFO - 2015-12-02 11:07:25,184 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,794 11:07:25 INFO - 2015-12-02 11:07:25,184 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:07:25 INFO - 2015-12-02 11:07:25,185 DEBUG : BROWSER_OUTPUT: __startTimestamp1449083245180__endTimestamp 11:07:25 INFO - 2015-12-02 11:07:25,185 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,192 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:07:25 INFO - 2015-12-02 11:07:25,192 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.80 Median:111.00 stddev:4.18 (3.8%) stddev-sans-first:4.43 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: Values: 111.0 107.0 111.0 110.0 112.0 123.0 111.0 110.0 112.0 111.0 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:153.00 stddev:17.40 (11.4%) stddev-sans-first:18.25 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: Values: 157.0 129.0 153.0 174.0 137.0 153.0 152.0 132.0 178.0 131.0 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.90 Median:165.00 stddev:2.51 (1.5%) stddev-sans-first:2.67 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: Values: 165.0 168.0 163.0 162.0 164.0 165.0 170.0 165.0 165.0 162.0 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:73.00 stddev:20.35 (27.9%) stddev-sans-first:21.43 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 72.0 72.0 73.0 73.0 137.0 73.0 72.0 73.0 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.20 Median:94.00 stddev:21.04 (22.4%) stddev-sans-first:21.85 11:07:25 INFO - 2015-12-02 11:07:25,193 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 138.0 95.0 93.0 94.0 139.0 94.0 94.0 136.0 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 147.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: Values: 96.0 98.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.10 Median:72.50 stddev:0.88 (1.2%) stddev-sans-first:0.87 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 73.0 71.0 72.0 72.0 71.0 71.0 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:70.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 69.0 70.0 70.0 70.0 70.0 70.0 70.0 70.0 11:07:25 INFO - 2015-12-02 11:07:25,194 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:2.76 (3.3%) stddev-sans-first:2.92 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 83.0 84.0 84.0 92.0 84.0 82.0 83.0 84.0 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:126.50 stddev:5.76 (4.6%) stddev-sans-first:5.61 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: Values: 117.0 126.0 127.0 114.0 124.0 129.0 130.0 122.0 117.0 129.0 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:147.50 stddev:5.36 (3.6%) stddev-sans-first:4.76 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: Values: 136.0 148.0 148.0 135.0 148.0 150.0 140.0 146.0 145.0 147.0 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.25 (1.8%) stddev-sans-first:0.87 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: Values: 72.0 68.0 69.0 69.0 70.0 68.0 69.0 68.0 70.0 70.0 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:07:25 INFO - 2015-12-02 11:07:25,195 DEBUG : BROWSER_OUTPUT: 11:07:26 INFO - 2015-12-02 11:07:26,126 INFO : Browser exited with error code: 0 11:07:26 INFO - 2015-12-02 11:07:26,179 INFO : Completed test kraken (00:01:01) 11:07:26 INFO - 2015-12-02 11:07:26,179 INFO : Starting test v8_7 11:07:26 INFO - 2015-12-02 11:07:26,179 DEBUG : operating with platform_type : linux_ 11:07:26 INFO - 2015-12-02 11:07:26,179 INFO : Initialising browser for v8_7 test... 11:07:26 INFO - 2015-12-02 11:07:26,185 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNVvMjv/profile http://localhost:41699/getInfo.html 11:07:31 INFO - 2015-12-02 11:07:31,122 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:07:31 INFO - 2015-12-02 11:07:31,122 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:07:31 INFO - 2015-12-02 11:07:31,123 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:07:31 INFO - 2015-12-02 11:07:31,123 DEBUG : BROWSER_OUTPUT: __metrics 11:07:31 INFO - 2015-12-02 11:07:31,264 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:07:32 INFO - 2015-12-02 11:07:32,181 INFO : Browser initialized. 11:07:32 INFO - 2015-12-02 11:07:32,182 INFO : Running cycle 1/1 for v8_7 test... 11:07:32 INFO - 2015-12-02 11:07:32,182 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNVvMjv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:07:44 INFO - 2015-12-02 11:07:44,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 142737408 11:07:44 INFO - 2015-12-02 11:07:44,208 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41699/tests/v8_7/run.html (next: http://localhost:41699/tests/v8_7/run.html) 11:08:05 INFO - 2015-12-02 11:08:05,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 137461760 11:08:05 INFO - 2015-12-02 11:08:05,970 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,971 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:08:05 INFO - 2015-12-02 11:08:05,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:08:05 INFO - 2015-12-02 11:08:05,971 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:08:05 INFO - 2015-12-02 11:08:05,971 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:08:05 INFO - 2015-12-02 11:08:05,971 DEBUG : BROWSER_OUTPUT: |0;Richards;167.11229946524065 11:08:05 INFO - 2015-12-02 11:08:05,971 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.84288354898337 11:08:05 INFO - 2015-12-02 11:08:05,971 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.1618625277162 11:08:05 INFO - 2015-12-02 11:08:05,971 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 11:08:05 INFO - 2015-12-02 11:08:05,971 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1086.9565217391305 11:08:05 INFO - 2015-12-02 11:08:05,972 DEBUG : BROWSER_OUTPUT: |5;Earley;717.8750897343862 11:08:05 INFO - 2015-12-02 11:08:05,972 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 11:08:05 INFO - 2015-12-02 11:08:05,972 DEBUG : BROWSER_OUTPUT: |7;RegExp;25575 11:08:05 INFO - 2015-12-02 11:08:05,972 DEBUG : BROWSER_OUTPUT: |8;Splay;597.9689366786141 11:08:05 INFO - 2015-12-02 11:08:05,972 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 11:08:05 INFO - 2015-12-02 11:08:05,972 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:08:05 INFO - 2015-12-02 11:08:05,972 DEBUG : BROWSER_OUTPUT: __startTimestamp1449083285964__endTimestamp 11:08:05 INFO - 2015-12-02 11:08:05,972 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,973 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:08:05 INFO - 2015-12-02 11:08:05,973 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:08:05 INFO - 2015-12-02 11:08:05,973 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,973 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.11 Median:167.11 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,973 DEBUG : BROWSER_OUTPUT: Values: 167.1 11:08:05 INFO - 2015-12-02 11:08:05,973 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,973 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.84 Median:184.84 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,974 DEBUG : BROWSER_OUTPUT: Values: 184.8 11:08:05 INFO - 2015-12-02 11:08:05,974 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,974 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.16 Median:277.16 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,974 DEBUG : BROWSER_OUTPUT: Values: 277.2 11:08:05 INFO - 2015-12-02 11:08:05,974 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,974 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,974 DEBUG : BROWSER_OUTPUT: Values: 5218.8 11:08:05 INFO - 2015-12-02 11:08:05,974 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,975 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1086.96 Median:1086.96 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,975 DEBUG : BROWSER_OUTPUT: Values: 1087.0 11:08:05 INFO - 2015-12-02 11:08:05,975 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,975 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:717.88 Median:717.88 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,975 DEBUG : BROWSER_OUTPUT: Values: 717.9 11:08:05 INFO - 2015-12-02 11:08:05,975 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,975 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,975 DEBUG : BROWSER_OUTPUT: Values: 12120.5 11:08:05 INFO - 2015-12-02 11:08:05,976 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,976 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25575.00 Median:25575.00 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,976 DEBUG : BROWSER_OUTPUT: Values: 25575.0 11:08:05 INFO - 2015-12-02 11:08:05,976 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,976 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.97 Median:597.97 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,976 DEBUG : BROWSER_OUTPUT: Values: 598.0 11:08:05 INFO - 2015-12-02 11:08:05,976 DEBUG : BROWSER_OUTPUT: 11:08:05 INFO - 2015-12-02 11:08:05,976 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:08:05 INFO - 2015-12-02 11:08:05,977 DEBUG : BROWSER_OUTPUT: Values: 4826.9 11:08:05 INFO - 2015-12-02 11:08:05,977 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:08:05 INFO - 2015-12-02 11:08:05,977 DEBUG : BROWSER_OUTPUT: 11:08:06 INFO - 2015-12-02 11:08:06,849 INFO : Browser exited with error code: 0 11:08:06 INFO - 2015-12-02 11:08:06,866 INFO : Completed test v8_7 (00:00:40) 11:08:06 INFO - 2015-12-02 11:08:06,929 INFO : Completed test suite (00:20:16) 11:08:06 INFO - 2015-12-02 11:08:06,929 DEBUG : Working with test: dromaeo_css 11:08:06 INFO - 2015-12-02 11:08:06,930 DEBUG : Generating results file: dromaeo_css 11:08:06 INFO - 2015-12-02 11:08:06,931 DEBUG : Working with test: kraken 11:08:06 INFO - 2015-12-02 11:08:06,931 DEBUG : Generating results file: kraken 11:08:06 INFO - 2015-12-02 11:08:06,931 INFO : javascript benchmark 11:08:06 INFO - 2015-12-02 11:08:06,932 DEBUG : Working with test: v8_7 11:08:06 INFO - 2015-12-02 11:08:06,932 DEBUG : Generating results file: v8_7 11:08:06 INFO - 2015-12-02 11:08:06,932 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:08:06 INFO - 2015-12-02 11:08:06,989 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 11:08:06 INFO - 2015-12-02 11:08:06,989 DEBUG : process_Request line: dromaeo_css 6330.45 graph.html#tests=[[72,132,43]] 11:08:06 INFO - 2015-12-02 11:08:06,990 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:08:07 INFO - 2015-12-02 11:08:07,028 DEBUG : process_Request line: kraken 1529.80 graph.html#tests=[[232,132,43]] 11:08:07 INFO - 2015-12-02 11:08:07,029 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:08:07 INFO - 2015-12-02 11:08:07,061 DEBUG : process_Request line: v8_7 21382.95 graph.html#tests=[[230,132,43]] 11:08:07 INFO - 2015-12-02 11:08:07,062 INFO : javascript benchmark 11:08:07 INFO - 2015-12-02 11:08:07,066 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2624.291441310846, 2666.0802023301953, 2706.215197592698, 2715.86420678966, 2717.904873329433, 4539.341795439659, 4638.698484598499, 4670.859874203779, 4671.229247174212, 4679.04079663669, 4568.063546972871, 4628.884277893055, 4709.152352576543, 4805.303231031498, 4807.495213002628, 4296.5273819879785, 4322.632576231016, 4454.53227411122, 4457.041736026754, 4481.282994720846, 4123.690723195772, 4361.062371590107, 4391.824327026915, 4392.275274579691, 4493.146302202587, 4206.495220573551, 4283.400323954649, 4290.2706539888295, 4311.741295522279, 4329.307310830283, 4337.219300525904, 4339.284018137004, 4351.412559304485, 4365.388845561624, 4387.583179597933, 4193.0, 4312.05134870328, 4316.352547117926, 4328.653707703376, 4373.825046998117, 4529.886752831173, 4618.745968971705, 4622.8150873965005, 4658.813647454098, 4666.4633567139535, 5078.263651770472, 5104.540591346759, 5108.233764935252, 5127.077126117298, 5127.7948882044675, 4875.780589873464, 4953.6037117030555, 5006.1489546776775, 5065.392152941634, 5165.147750621143, 4645.74448405341, 4696.201645720235, 4713.740744259098, 4741.810327586927, 4776.47458779534, 5128.410232823198, 5129.461406552333, 5138.640295179376, 5139.614528910347, 5160.587153027749, 4785.521447855256, 4862.975685121552, 4899.436564795023, 4990.975045124751, 5006.6245031622775, 5025.095482813129, 5063.088644044107, 5074.949250507448, 5080.949190508048, 5123.129068058439, 4990.925136122961, 5018.874528136753, 5029.396472423333, 5031.6729412588065, 5049.116404629175, 4774.570288674036, 4887.853364399074, 4889.877753056131, 4933.802647894116, 4981.252812078144, 4161.479815023122, 4180.47744031996, 4182.2681030819485, 4190.601892820177, 4219.451471308772, 3612.0608641753333, 3668.449732540087, 3700.0564855961557, 3712.480252764615, 3717.8141092945243, 4290.141971605692, 4360.0, 4371.956280437155, 4383.167198232326, 4389.824407023747, 5024.145895197825, 5048.29323894655, 5053.772580233898, 5076.796928122908, 5096.923546146811, 4381.627561657231, 4386.868393948187, 4388.934165987449, 4397.6921615487245, 4428.202923473806, 4304.053108316165, 4413.337999300131, 4425.800838962255, 4515.616172625364, 4568.885777855514, 4797.304390863305, 4805.207140821725, 4820.590249828663, 4829.637777166727, 4830.178869592178, 4903.8528844134735, 5047.87380315495, 5050.419201791841, 5071.112555302881, 5100.285959965534, 4738.407699037621, 4748.833790817304, 4807.6394270429155, 4830.516948305141, 4831.0820944020525, 4985.177445721561, 5069.163588008085, 5074.720890350918, 5075.695458272516, 5119.974400127976, 4880.072786170616, 4994.0, 5102.4897510248675, 5105.106606343801, 5168.198929165835, 4817.253325734517, 4848.75756212195, 4882.707037577615, 4909.165441874961, 4931.630127740362, 4963.70217786934, 4968.378952630921, 4972.204447288416, 4976.029674213493, 4979.203327467588, 4498.505164431845, 4616.261398176276, 4665.486796452456, 4858.82994095205, 4887.218045112765, 4915.582175515121, 4947.0, 4950.059488697136, 4964.528369804862, 4992.850214493571, 4825.6139508838505, 4836.564709176191, 4846.80612775485, 4887.951120488749, 4903.289023091703], "unit": "ms", "name": "dojo.html", "value": 4620.38392967685}, {"lowerIsBetter": false, "replicates": [554.8298081580531, 571.848460158058, 583.9357670656228, 595.4343373794896, 615.1971676961564, 27478.175654730367, 28142.57786133207, 36272.45591316129, 36857.63142368576, 36911.81544092276, 39107.60892391075, 39199.21601567967, 39606.405903911465, 39610.207795844064, 39742.20515589694, 7828.060632724067, 7912.446128770988, 7938.920610793876, 7953.801154971115, 7957.522548647071, 7817.179196184404, 7915.0, 7916.287534121928, 7930.088039875402, 7949.523028618272, 7884.172161923001, 7916.445848790559, 7945.64244608994, 7951.244631759973, 7955.0453945526615, 7920.089189743196, 7927.445078844455, 7937.563434011127, 7976.6011699415085, 7989.480683755537, 7705.845883082307, 7756.922430775677, 7777.300042996101, 7832.060152781646, 7837.6864925402915, 36432.817835910915, 36593.0, 36823.815880920694, 36829.0, 36907.815460922524, 2895.4643390972738, 2963.4369469800668, 3115.283484798509, 3254.8209848458328, 3454.1191996040848, 27468.58797118045, 27980.160595182177, 28177.85911070452, 28222.294442638893, 28324.150275491564, 3222.5810644616286, 3291.2857770149108, 3300.7689461737687, 3325.318309746496, 3425.1779572902324, 215583.0, 216283.0, 217721.0, 217865.0, 218129.0, 49972.25041624378, 51210.48789512057, 54121.0, 54565.1815222772, 54568.0, 65546.0, 66627.66686166538, 66959.66520167368, 66964.33035669678, 67061.0, 14180.361883715257, 14366.712665746627, 14388.136711797326, 14392.0, 14393.92803035978, 10691.946540267405, 10768.892311076946, 10778.838317425245, 10803.189760767973, 10864.891351086546, 18932.905335473235, 19305.903470482557, 19330.903345483184, 19442.222311107398, 19514.0, 7581.431392645573, 7790.922090779133, 7807.843843123106, 7859.921400785919, 7907.209279072162, 766.52858492027, 775.2751177648917, 804.3846457460048, 853.8078932240196, 895.4850960697624, 25483.36291592725, 25634.871825640752, 25661.61507577388, 26033.219003429927, 29508.852455737582, 883.4346018548134, 935.4995077633433, 937.9108984646448, 1012.367270455965, 1053.2469284461495, 13673.86326136726, 13825.0, 13831.446742130202, 13843.515476958259, 14032.789508157386, 318542.0, 321087.0, 322001.0, 322125.0, 322821.0, 45334.31998520025, 45490.0, 45922.77038614786, 45940.86532212117, 46150.30774538385, 1134.6652737442473, 1188.6671731915078, 1192.6064398748392, 1195.2290772451893, 1207.7644859252537, 25662.61506077373, 26111.608325874746, 26131.608025879246, 26171.869140654177, 26592.0, 38174.0, 39209.0, 39236.41145382878, 39283.80358098191, 39334.80332598319, 248300.0, 249903.0, 250090.0, 250541.0, 250564.0, 24355.14756983497, 24922.750772492043, 28469.857650711612, 28481.715182847907, 28657.0, 33604.0, 33652.0, 34120.0, 34375.48436773501, 34542.13644658803, 30475.695243047285, 31149.844250778602, 31452.370952581277, 31529.684703152674, 31563.684363156073, 31635.84182079075, 31731.36537269288, 31733.0, 32111.197220069684, 32229.51655725119, 32152.839235803673, 32207.35585288328, 32325.35349292954, 32615.836920815244, 32681.0, 27952.860235698692, 28953.710462895942, 33409.0, 34790.30419391648, 34982.65017349794, 24073.398165046015, 24400.51198975975, 24581.754182458662, 24668.87665561661, 24809.751902480744], "unit": "ms", "name": "ext.html", "value": 16817.403464502717}, {"lowerIsBetter": false, "replicates": [334.71883617761074, 335.34607515345067, 337.6792047554823, 338.31153602419084, 339.24517947566665, 15088.321025553849, 15237.16195609241, 15381.769273460906, 15659.373625054985, 15888.364465421399, 9568.0, 9754.414735115897, 9817.410955342684, 10213.642522511713, 10217.693469195936, 4520.90958180837, 4631.791569379386, 4636.188666983281, 4641.559051890065, 4645.349651048856, 4596.655250856183, 4904.779284932187, 4996.850094497171, 5015.0, 5021.271915572258, 4758.405199350082, 4934.037862616791, 4942.579880710126, 5001.399832020163, 5015.7492125393765, 4880.194767863299, 4926.236433352836, 4926.704397736147, 4937.876553086166, 4962.503749625044, 4997.325361076245, 4998.550130488274, 5001.699898006132, 5003.799848006075, 5005.524475174852, 15876.967997080268, 17941.64116717658, 17956.730649040273, 18726.063696815105, 18772.249110035584, 1811.0401487211798, 1890.5840715042807, 1908.6182763447366, 1917.7890432052463, 1939.2727727102338, 8319.417640765088, 8650.35122365825, 8934.240589549896, 8976.775580610538, 11909.22590031645, 1723.2159367487764, 1767.6199617082261, 1773.2640954004073, 1783.3134243316288, 1800.5768644368563, 56587.43412565863, 56715.0, 57246.42753572453, 57808.421915780724, 58034.70982645102, 9911.65309214174, 9915.603375865028, 9932.702018939442, 9973.30186886911, 9977.501124943723, 12321.691957701129, 12330.075244356709, 12420.192687475466, 12458.81311780324, 12501.24992500453, 7236.710531578678, 7267.164276108315, 7372.299631534996, 7374.299441553044, 7433.0, 7273.490855640161, 7276.927230727731, 7313.451491138186, 7357.742479013209, 7369.926300737031, 4095.9385609215888, 4172.248995180897, 4234.280172370704, 4234.978825105854, 4239.4737894358, 1670.1148391352604, 1734.531676447352, 1837.366108692499, 1840.7083181439193, 1854.870159088878, 353.7682817754375, 355.96440355964194, 367.59197291007496, 372.7148731220618, 788.731831177391, 9456.243500519942, 15223.31495082724, 16004.439844605384, 16251.756223656655, 16794.748078778826, 827.71443851871, 844.1980118887082, 851.131845517581, 874.3748220022715, 878.1262643669589, 8407.075221725605, 8450.830983380298, 9058.592363343665, 9092.318076144184, 9253.306002049872, 503048.0, 503814.0, 506316.0, 515560.0, 516062.0, 68833.65583172052, 69863.0, 70260.0, 71259.0, 71506.0, 1082.0640146273574, 1082.1937656445998, 1098.8461615373853, 1109.8446217529552, 1110.3116068037707, 14025.438982440588, 14032.438702452197, 14093.718125637635, 14107.788383174466, 14292.28538573088, 32084.35831283408, 32109.51835722419, 34100.488492672135, 34587.30825383428, 35717.846957700436, 41166.79416602898, 41315.1736965253, 41631.58368416277, 42158.0, 43697.34453983129, 8089.2315230053055, 8532.616032278438, 8651.783705407415, 8679.392442528962, 8731.65073397057, 10160.034796694303, 10198.59205631796, 11460.426978651201, 15769.921150394175, 15941.920290398937, 13047.0, 13525.59423217305, 13588.184708917497, 13887.861121388656, 13901.0964287321, 13110.672233194246, 13338.599842004756, 13391.933040334736, 13870.930645346709, 13872.098313609584, 13853.37659805291, 14586.635334116732, 14607.0, 14620.342084606005, 14790.03864748788, 8790.780230494032, 8932.642694292155, 8993.685221017233, 9000.369974102012, 9044.592993315186, 9112.772180695536, 10593.364398136137, 14162.575122746333, 14227.857721422653, 14303.713925721635], "unit": "ms", "name": "jquery.html", "value": 7973.748930054746}, {"lowerIsBetter": false, "replicates": [1407.4933024111317, 1480.5484327280176, 1568.6078480379906, 1578.7158311503938, 1667.9249433775478, 7041.647917604118, 7099.006139140512, 7411.88882166768, 7412.555246685202, 7428.33145016949, 7435.962820185905, 7469.215732348107, 7553.206913274096, 7556.433267504945, 7576.5075270107545, 2061.0622166914054, 2091.215794077221, 2097.2345094040716, 2100.6323893318686, 2104.831613470926, 2125.298651445027, 2128.0317455557683, 2146.6994620753107, 2147.6778483227486, 2154.8707077575395, 1986.6721990871488, 2046.8362530997485, 2062.597793430282, 2067.9896600516977, 2075.730155079845, 2079.979200208001, 2101.495641046153, 2110.3457928042358, 2111.9049642766036, 2113.704081428601, 2048.283100914683, 2083.114676262582, 2086.603545326383, 2093.2255065625664, 2103.9579208415744, 7167.068281123473, 7209.89185162223, 7218.530795498328, 7248.8550228995655, 7278.272172782679, 4190.580941905816, 4251.829926802924, 4265.232258193524, 4287.164003019412, 4295.78521073945, 2729.440464704731, 2747.5329194037063, 2748.491529067109, 2761.6962134165224, 2795.804293699442, 863.1066845814552, 868.6091258933442, 871.0766587417357, 871.1462766488813, 908.7546362482093, 9388.62445502179, 9395.295352848496, 9437.622495100188, 9453.52732363386, 9507.286953478517, 3660.4692319613505, 3718.4050551911564, 3741.9438708419398, 3763.4354846773203, 3763.8118094095184, 7601.429892758065, 7634.923650763532, 7640.0, 7666.8849967250535, 7667.11828139771, 4042.7372220805555, 4082.795860206978, 4108.50697916246, 4117.526484454326, 4119.97940010298, 3808.3906574947873, 3827.2154208387215, 3832.0419895026243, 3836.175222327213, 3846.9230615387537, 3032.9233122241726, 3051.92370190747, 3077.815331080142, 3090.196548897303, 3101.968980310168, 908.5321059654283, 911.9908800912038, 915.8992510823804, 916.3493919317226, 916.5005072235648, 893.2809088683672, 897.3763234552055, 899.9460032398077, 905.5698543192062, 1200.2378489658954, 6792.728290868409, 6820.624865632339, 6838.111045564145, 6842.076319696876, 6904.654767261617, 981.1856159387834, 994.0705440413092, 996.3872218585662, 1064.5316060933164, 1079.4117206122683, 5503.642263252956, 5523.8066667666435, 5528.695921724263, 5540.806071787468, 5548.69482178484, 8290.922180116546, 8429.072801991775, 8576.185262400062, 8588.613512391958, 8595.699150529827, 8624.74125776215, 8671.0, 8696.130386961253, 8773.385862989657, 8810.383273170817, 6391.648459334781, 6408.775692850728, 6483.124778154889, 6507.934920650733, 6551.770688025991, 6473.64394958263, 6522.641254731036, 6547.574407663486, 6549.345065493412, 6552.3775241352, 7617.847643046997, 7802.453828231969, 7812.57030863308, 7819.804504887424, 7899.09160446556, 7952.244536768998, 8046.597670116354, 8070.435069545076, 8152.592370381576, 8158.592070396575, 6581.407673309425, 6624.6025238485845, 6718.496112791658, 6735.225449073419, 6742.831429214309, 6739.797806065826, 6841.042254084333, 6856.211535673262, 6859.176898772179, 6878.58728476293, 6067.453929146398, 6111.602745821508, 6164.47601953839, 6490.610563366213, 6538.574992625464, 6390.0, 6445.774397896051, 6453.580517266362, 6552.57408268461, 6589.4069533742195, 6611.0, 6679.265280819009, 6693.799186024427, 6700.664966751546, 6710.563813352116, 5927.792527261525, 5988.251468566429, 6002.249718785152, 6079.483243924316, 6109.1141784440115, 6229.283632382334, 6230.844228894314, 6245.8750824982335, 6246.031865060741, 6263.185785847811], "unit": "ms", "name": "mootools.html", "value": 4086.2867656470557}, {"lowerIsBetter": false, "replicates": [293.495188276165, 294.305439163574, 298.1235168604303, 306.32455435764126, 308.434023566755, 5545.722713864306, 5572.136318870582, 5618.634788738735, 5689.943100568993, 5711.371749107595, 5562.360328562207, 5609.074502707049, 5631.4087020862835, 5631.746571404286, 5632.831015069544, 4146.60607242313, 4286.5284818669925, 4286.699931004831, 4291.699581029329, 4294.420253265808, 4231.322988321869, 4276.893077673068, 4293.65650747941, 4294.9570504295025, 4297.419848320468, 4232.15356928614, 4236.258654735424, 4242.596953289432, 4243.363495475673, 4243.702940794145, 4232.809523571446, 4243.448351714288, 4243.872683819491, 4250.659947204216, 4254.787260636956, 3698.7595806272507, 3699.9445008324897, 3701.777893326409, 3702.4631428442726, 3708.8887333380044, 5200.479952004769, 5228.08508511009, 5316.601254905859, 5378.327709036371, 5381.704006279653, 4880.170371036932, 4883.633727470454, 4884.975575122137, 4889.193283108283, 4897.534734200245, 5858.033424484955, 5858.443447872445, 5860.062390017577, 5862.443067908542, 5869.471747542699, 3860.247251785903, 3970.8411663533425, 3976.1451287973223, 4000.2599519089063, 4020.135670830756, 6051.969740151271, 6136.969315153396, 6141.999999999955, 6144.477719393857, 6161.7227224775, 4071.776052317151, 4096.795160242035, 4101.712880098365, 4106.67146628275, 4107.424960505532, 4151.750894946253, 4169.958300416957, 4170.4995400552125, 4170.958290417057, 4174.3112386456505, 4729.125111854318, 4822.807087716522, 4823.397075365579, 4830.275458681155, 4838.879028024327, 5798.536117110621, 5802.506786923159, 5810.389909059488, 5811.4479124483105, 5818.44724751148, 1463.6706740983193, 1486.5763257471785, 1487.0, 1488.694817562397, 1489.143742348154, 981.1954197557934, 982.8083523712808, 987.7975015121883, 1000.5447521377756, 1003.1573478278282, 5098.1842905135745, 5101.821436249714, 5107.463716309809, 5112.642115051911, 5112.769925353368, 6033.095035744674, 6048.909266361008, 6055.152278680988, 6057.757689692363, 6067.696615169224, 5093.923591146136, 5095.847124586268, 5106.617003724736, 5108.56577190943, 5124.9743751281, 3188.3304506053523, 3265.755068369882, 3269.2807582331848, 3289.967100329014, 3294.4893541501106, 5650.208970744099, 5747.683877386784, 5759.366469688331, 5761.279840019997, 5774.047282198474, 6258.968705156445, 6263.498920086382, 6294.181756371642, 6329.493640508748, 6343.936560634427, 5820.417958204146, 5821.941780582225, 5825.271841019872, 5830.921279563295, 5838.94161058384, 6107.480864126599, 6123.050927106306, 6130.969345153246, 6147.538934579835, 6148.016317389196, 5766.106253530709, 5916.437938395846, 5952.494038006645, 5982.4316689914385, 5989.431004054608, 5758.395368486416, 5785.595008349375, 5800.0, 5803.0, 5817.680027598522, 4191.664666826708, 4241.63946064588, 4241.87274381769, 4250.702450828412, 4252.107057517832, 5888.94111058901, 6037.879242415215, 6041.335453100243, 6042.335343112166, 6051.062085376773, 5820.5925585210325, 5822.010258256191, 5828.329742079545, 5841.532677385884, 5842.620229685227, 5791.189233507396, 5799.652020878761, 5809.9419005809405, 5810.535157187331, 5843.545710801389, 5536.446355364431, 5664.830055098354, 5672.688002159755, 5675.772969081356, 5707.771689132388, 5843.386444423274, 5847.8538036547725, 5851.180834683063, 5854.356020837619, 5862.384449632727, 5625.212470254086, 5632.605717599728, 5673.8297851064535, 5682.744276507485, 5685.829425117253], "unit": "ms", "name": "prototype.html", "value": 4365.64059432891}, {"lowerIsBetter": false, "replicates": [551.9558435325174, 618.6721037849939, 670.2191946382463, 670.8423520472688, 675.5912672832933, 12030.51877924882, 12455.128141030109, 12456.564020259293, 12461.875381246196, 12463.314517701523, 13706.451741930336, 14005.0, 14016.0, 14028.43886244549, 14058.0, 630.5050535329767, 638.0270088115637, 818.7461886815091, 831.2560258568577, 833.3666413525704, 804.9074356448996, 807.7778610881995, 812.4475356757403, 814.7107776739261, 815.3436483630675, 846.1580727176469, 851.93610479214, 852.5353682243192, 853.6372041882206, 856.6273670953155, 846.2975730143966, 852.6972924611766, 854.1970547685219, 854.2653318146389, 857.1514200941086, 621.937806219379, 627.5387590121258, 628.2335550628226, 628.7736414890636, 629.2197674883158, 12040.39798010096, 12057.758844823142, 12120.696982575419, 12190.329531875743, 12199.268043917393, 10902.781944361068, 10966.945165274123, 11106.44467776608, 11178.217524773268, 11499.77000459986, 9415.246780257632, 9519.143277105093, 9521.90478095217, 9608.327417080807, 9646.614135434575, 3355.647656996029, 3361.210115622827, 3368.3936891359544, 3388.8983330500123, 3396.473546600256, 43071.35392969108, 43230.13539729219, 43339.349909751065, 43345.56654433478, 43627.56372436267, 9521.0, 9575.664851730156, 9632.0, 9702.90297097034, 9759.804803903882, 16350.710900473943, 16368.590785230464, 16370.181490925406, 16403.0, 16427.58931026734, 6258.249010118724, 6305.653189074553, 6327.651979141099, 6438.420542151229, 6558.0, 3585.2112535242204, 3620.0768803954825, 3627.3108109459117, 3637.2907283080076, 3643.3441980443245, 2771.8198317109322, 2772.3900741836765, 2791.3300807806386, 2792.720727927191, 2803.649543807024, 510.5354127743735, 513.3403576404303, 517.5936889541691, 518.8988147311313, 521.48633595908, 553.396797490729, 595.6574969392617, 599.6342231238941, 601.3595520770366, 638.7125793392992, 7403.703851845974, 7587.696492140363, 7636.0, 7647.885281720779, 7691.5769632670745, 575.9164921086419, 578.5574035862569, 579.0214537431727, 590.9556783241188, 591.7662523303271, 3528.0, 3606.2787442511603, 3652.5982141964364, 3695.611960744137, 3776.6223377662013, 50624.74687626538, 51390.0, 51716.74141629268, 51850.74074629678, 51932.0, 45141.322880156826, 45532.08935821265, 46088.308675369895, 46408.0, 46463.0, 42358.78820605877, 42966.57033429626, 43233.78383108064, 43432.13135737267, 43605.127897441875, 7389.113306403266, 7507.737229196952, 7519.699212031676, 7537.434692398202, 7601.581912994839, 31863.84068079645, 31886.6811331893, 32532.02403927886, 32873.342533149684, 33202.667973320924, 37041.44437833488, 37055.44416833696, 39615.0, 40573.1885362297, 41247.381289281286, 8829.16122968317, 9033.954830225806, 9418.62325506972, 9419.387739796892, 9421.81156376855, 10253.33353332031, 11633.59282425111, 11780.882191177978, 11890.76218475643, 11933.403329833647, 10821.134309255083, 10855.837162442413, 10962.287451315959, 11097.167712421762, 11126.332420054823, 10763.085137763064, 10819.18856085781, 11012.0, 11082.889171108185, 11197.552097915992, 11035.282706624364, 11094.722631934266, 11121.833172502256, 11125.276857004268, 11391.943040285078, 9130.132637399702, 9135.177833994972, 9142.817143657223, 9464.242860571276, 9464.337496375188, 9137.680181193626, 9183.77040573991, 9190.21883139914, 9296.302777291865, 9311.394759340621], "unit": "ms", "name": "yui.html", "value": 5822.203114253815}], "name": "dromaeo_css", "value": 6330.4481575678265}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 110.0, 112.0, 123.0, 111.0, 110.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 153.0, 174.0, 137.0, 153.0, 152.0, 132.0, 178.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [165.0, 168.0, 163.0, 162.0, 164.0, 165.0, 170.0, 165.0, 165.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 164.9}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 72.0, 72.0, 73.0, 73.0, 137.0, 73.0, 72.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 138.0, 95.0, 93.0, 94.0, 139.0, 94.0, 94.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 107.2}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 73.0, 71.0, 72.0, 72.0, 71.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.1}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 84.0, 84.0, 92.0, 84.0, 82.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [117.0, 126.0, 127.0, 114.0, 124.0, 129.0, 130.0, 122.0, 117.0, 129.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 148.0, 135.0, 148.0, 150.0, 140.0, 146.0, 145.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 69.0, 69.0, 70.0, 68.0, 69.0, 68.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1529.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.11229946524065], "unit": "score", "name": "Richards", "value": 211.24716800000004}, {"lowerIsBetter": false, "replicates": [184.84288354898337], "unit": "score", "name": "DeltaBlue", "value": 357.6983799999999}, {"lowerIsBetter": false, "replicates": [277.1618625277162], "unit": "score", "name": "Encrypt", "value": 960.3810479999997}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1086.9565217391305], "unit": "score", "name": "RayTrace", "value": 680.7898799999998}, {"lowerIsBetter": false, "replicates": [717.8750897343862], "unit": "score", "name": "Earley", "value": 928.3829590000004}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [25575.0], "unit": "score", "name": "RegExp", "value": 35.620136852394914}, {"lowerIsBetter": false, "replicates": [597.9689366786141], "unit": "score", "name": "Splay", "value": 136.27965434565436}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 21382.946422641446}]} 11:08:07 INFO - RETURN: dromaeo_css: 6330.45 11:08:07 INFO - RETURN: kraken: 1529.80 11:08:07 INFO - RETURN: v8_7: 21382.95 11:08:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21382.95"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1529.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6330.45"}}} 11:08:07 INFO - Return code: 0 11:08:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:08:07 INFO - # TBPL SUCCESS # 11:08:07 INFO - Running post-action listener: _resource_record_post_action 11:08:07 INFO - Running post-run listener: _resource_record_post_run 11:08:08 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 73728; Write bytes: 505348096; Read time: 40; Write time: 444552 11:08:08 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 230354944; Read time: 0; Write time: 285924 11:08:08 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 73728; Write bytes: 274591744; Read time: 40; Write time: 158600 11:08:08 INFO - Running post-run listener: _upload_blobber_files 11:08:08 INFO - Blob upload gear active. 11:08:08 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:08:08 INFO - Copying logs to upload dir... 11:08:08 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.097369 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-12-02 11:08:08.185996) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 11:08:08.189733) ========= 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=3cd289541638898829117e0a000001bd-1449080384.963748-1575825979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010137 build_url: 'https://queue.taskcluster.net/v1/task/skZSyFHZTxmczj5dQAaKDA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 11:08:08.240767) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 11:08:08.241190) ========= 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=3cd289541638898829117e0a000001bd-1449080384.963748-1575825979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004716 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 11:08:08.291266) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 11:08:08.291576) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 11:08:08.291865) ========= ========= Total master_lag: 0.23 =========