builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1448642857.62 results: success (0) buildid: 20151127082132 builduid: 07a49db1ac9342aaa4ad9a8f8746960a revision: 2f801d6ef06489fa9dfbdf160350fcd7e4afbc5d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.620869) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.621359) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.621660) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006517 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.653921) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.654227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.683630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.683894) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.733495) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.733757) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.734162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:37.734437) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-27 08:47:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2015-11-27 08:47:38 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.361338 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:38.107658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:38.107966) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016191 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:38.156832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:38.157218) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f801d6ef06489fa9dfbdf160350fcd7e4afbc5d --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 2f801d6ef06489fa9dfbdf160350fcd7e4afbc5d --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=1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-27 08:47:38,539 truncating revision to first 12 chars 2015-11-27 08:47:38,539 Setting DEBUG logging. 2015-11-27 08:47:38,539 attempt 1/10 2015-11-27 08:47:38,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f801d6ef064?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-27 08:47:38,771 unpacking tar archive at: fx-team-2f801d6ef064/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549495 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:38.721637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:38.722204) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:38.732570) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:38.732853) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 08:47:38.733270) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-11-27 08:47:38.733554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:47:39 INFO - MultiFileLogger online at 20151127 08:47:39 in /builds/slave/test 08:47:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 08:47:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:39 INFO - {'append_to_log': False, 08:47:39 INFO - 'base_work_dir': '/builds/slave/test', 08:47:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:47:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:39 INFO - 'branch': 'Fx-Team-Non-PGO', 08:47:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:39 INFO - 'config_files': ('talos/linux_config.py',), 08:47:39 INFO - 'default_actions': ('clobber', 08:47:39 INFO - 'read-buildbot-config', 08:47:39 INFO - 'download-and-extract', 08:47:39 INFO - 'populate-webroot', 08:47:39 INFO - 'create-virtualenv', 08:47:39 INFO - 'install', 08:47:39 INFO - 'run-tests'), 08:47:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:39 INFO - 'download_minidump_stackwalk': True, 08:47:39 INFO - 'download_symbols': 'ondemand', 08:47:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:39 INFO - 'installer_path': 'installer.exe', 08:47:39 INFO - 'log_level': 'info', 08:47:39 INFO - 'log_name': 'talos', 08:47:39 INFO - 'log_to_console': True, 08:47:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:47:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:47:39 INFO - 'opt_config_files': (), 08:47:39 INFO - 'pip_index': False, 08:47:39 INFO - 'sps_profile': False, 08:47:39 INFO - 'sps_profile_interval': 0, 08:47:39 INFO - 'suite': 'dromaeojs', 08:47:39 INFO - 'system_bits': '64', 08:47:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:39 INFO - 'title': 'talos-linux64-ix-029', 08:47:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:39 INFO - 'use_talos_json': True, 08:47:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:39 INFO - 'work_dir': 'build'} 08:47:39 INFO - ##### 08:47:39 INFO - ##### Running clobber step. 08:47:39 INFO - ##### 08:47:39 INFO - Running pre-action listener: _resource_record_pre_action 08:47:39 INFO - Running main action method: clobber 08:47:39 INFO - rmtree: /builds/slave/test/build 08:47:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:39 INFO - Running post-action listener: _resource_record_post_action 08:47:39 INFO - ##### 08:47:39 INFO - ##### Running read-buildbot-config step. 08:47:39 INFO - ##### 08:47:39 INFO - Running pre-action listener: _resource_record_pre_action 08:47:39 INFO - Running main action method: read_buildbot_config 08:47:39 INFO - Using buildbot properties: 08:47:39 INFO - { 08:47:39 INFO - "properties": { 08:47:39 INFO - "buildnumber": 2135, 08:47:39 INFO - "product": "firefox", 08:47:39 INFO - "script_repo_revision": "production", 08:47:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:47:39 INFO - "repository": "", 08:47:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:47:39 INFO - "buildid": "20151127082132", 08:47:39 INFO - "slavename": "talos-linux64-ix-029", 08:47:39 INFO - "pgo_build": "False", 08:47:39 INFO - "basedir": "/builds/slave/test", 08:47:39 INFO - "project": "", 08:47:39 INFO - "platform": "ubuntu64_hw", 08:47:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:47:39 INFO - "slavebuilddir": "test", 08:47:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:47:39 INFO - "branch": "fx-team", 08:47:39 INFO - "repo_path": "integration/fx-team", 08:47:39 INFO - "stage_platform": "linux64", 08:47:39 INFO - "builduid": "07a49db1ac9342aaa4ad9a8f8746960a", 08:47:39 INFO - "revision": "2f801d6ef06489fa9dfbdf160350fcd7e4afbc5d" 08:47:39 INFO - }, 08:47:39 INFO - "sourcestamp": { 08:47:39 INFO - "repository": "", 08:47:39 INFO - "hasPatch": false, 08:47:39 INFO - "project": "", 08:47:39 INFO - "branch": "fx-team-linux64-talos", 08:47:39 INFO - "changes": [ 08:47:39 INFO - { 08:47:39 INFO - "category": null, 08:47:39 INFO - "files": [ 08:47:39 INFO - { 08:47:39 INFO - "url": null, 08:47:39 INFO - "name": "https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:47:39 INFO - } 08:47:39 INFO - ], 08:47:39 INFO - "repository": "", 08:47:39 INFO - "rev": "2f801d6ef06489fa9dfbdf160350fcd7e4afbc5d", 08:47:39 INFO - "who": "ryanvm@gmail.com", 08:47:39 INFO - "when": 1448642848, 08:47:39 INFO - "number": 6715334, 08:47:39 INFO - "comments": "Bug 1228603 - Update pdf.js to version 1.3.38. r=bdahl", 08:47:39 INFO - "project": "", 08:47:39 INFO - "at": "Fri 27 Nov 2015 08:47:28", 08:47:39 INFO - "branch": "fx-team-linux64-talos", 08:47:39 INFO - "revlink": "", 08:47:39 INFO - "properties": [ 08:47:39 INFO - [ 08:47:39 INFO - "buildid", 08:47:39 INFO - "20151127082132", 08:47:39 INFO - "Change" 08:47:39 INFO - ], 08:47:39 INFO - [ 08:47:39 INFO - "builduid", 08:47:39 INFO - "07a49db1ac9342aaa4ad9a8f8746960a", 08:47:39 INFO - "Change" 08:47:39 INFO - ], 08:47:39 INFO - [ 08:47:39 INFO - "pgo_build", 08:47:39 INFO - "False", 08:47:39 INFO - "Change" 08:47:39 INFO - ] 08:47:39 INFO - ], 08:47:39 INFO - "revision": "2f801d6ef06489fa9dfbdf160350fcd7e4afbc5d" 08:47:39 INFO - } 08:47:39 INFO - ], 08:47:39 INFO - "revision": "2f801d6ef06489fa9dfbdf160350fcd7e4afbc5d" 08:47:39 INFO - } 08:47:39 INFO - } 08:47:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:47:39 INFO - Running post-action listener: _resource_record_post_action 08:47:39 INFO - ##### 08:47:39 INFO - ##### Running download-and-extract step. 08:47:39 INFO - ##### 08:47:39 INFO - Running pre-action listener: _resource_record_pre_action 08:47:39 INFO - Running main action method: download_and_extract 08:47:39 INFO - mkdir: /builds/slave/test/build/tests 08:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:39 INFO - https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:47:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/test_packages.json 08:47:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/test_packages.json 08:47:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:47:41 INFO - Downloaded 1302 bytes. 08:47:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:47:41 INFO - Using the following test package requirements: 08:47:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:47:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:41 INFO - u'jsshell-linux-x86_64.zip'], 08:47:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:47:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:47:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:47:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:47:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:47:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:41 INFO - https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/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 08:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/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 08:47:43 INFO - Downloaded 21518599 bytes. 08:47:43 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 08:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:47:43 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 08:47:44 INFO - Return code: 0 08:47:44 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 08:47:44 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')]} 08:47:44 INFO - https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/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 08:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/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 08:47:52 INFO - Downloaded 21518599 bytes. 08:47:52 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 08:47:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:47:52 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 08:47:54 INFO - Return code: 0 08:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:54 INFO - https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:47:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:47:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:47:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/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 08:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/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 08:47:55 INFO - Downloaded 11131728 bytes. 08:47:55 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 08:47:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:47:55 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 08:47:55 INFO - Return code: 0 08:47:55 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')]} 08:47:55 INFO - https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:47:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:47:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:47:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/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 08:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ggIMCb0-RFmPMJEWruhbcQ/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 08:47:57 INFO - Downloaded 56880592 bytes. 08:47:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:47:57 INFO - mkdir: /builds/slave/test/properties 08:47:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:47:57 INFO - Writing to file /builds/slave/test/properties/build_url 08:47:57 INFO - Contents: 08:47:57 INFO - build_url:https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:47:57 INFO - Running post-action listener: _resource_record_post_action 08:47:57 INFO - Running post-action listener: set_extra_try_arguments 08:47:57 INFO - ##### 08:47:57 INFO - ##### Running populate-webroot step. 08:47:57 INFO - ##### 08:47:57 INFO - Running pre-action listener: _resource_record_pre_action 08:47:57 INFO - Running main action method: populate_webroot 08:47:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:47:57 INFO - '../fennec_ids.txt'], 08:47:57 INFO - 'tests': ['tcheck2']}, 08:47:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:57 INFO - '--tppagecycles', 08:47:57 INFO - '7'], 08:47:57 INFO - 'tests': ['tsvgm']}}, 08:47:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:47:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:47:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:47:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:47:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:47:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:57 INFO - 'talos_options': ['--e10s'], 08:47:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:57 INFO - 'tests': ['damp', 'tps']}, 08:47:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:57 INFO - 'talos_options': ['--e10s'], 08:47:57 INFO - 'tests': ['damp', 'tps']}, 08:47:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:47:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:57 INFO - 'other': {'tests': ['a11yr', 08:47:57 INFO - 'ts_paint', 08:47:57 INFO - 'tpaint', 08:47:57 INFO - 'sessionrestore', 08:47:57 INFO - 'sessionrestore_no_auto_restore']}, 08:47:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:47:57 INFO - 'tests': ['a11yr', 08:47:57 INFO - 'ts_paint', 08:47:57 INFO - 'tpaint', 08:47:57 INFO - 'sessionrestore', 08:47:57 INFO - 'sessionrestore_no_auto_restore']}, 08:47:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:47:57 INFO - 'tests': ['a11yr', 08:47:57 INFO - 'ts_paint', 08:47:57 INFO - 'tpaint', 08:47:57 INFO - 'sessionrestore', 08:47:57 INFO - 'sessionrestore_no_auto_restore']}, 08:47:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:47:57 INFO - 'tests': ['a11yr', 08:47:57 INFO - 'ts_paint', 08:47:57 INFO - 'tpaint', 08:47:57 INFO - 'sessionrestore', 08:47:57 INFO - 'sessionrestore_no_auto_restore']}, 08:47:57 INFO - 'other_l64': {'tests': ['a11yr', 08:47:57 INFO - 'ts_paint', 08:47:57 INFO - 'tpaint', 08:47:57 INFO - 'sessionrestore', 08:47:57 INFO - 'sessionrestore_no_auto_restore']}, 08:47:57 INFO - 'other_nol64': {'tests': ['a11yr', 08:47:57 INFO - 'ts_paint', 08:47:57 INFO - 'tpaint', 08:47:57 INFO - 'sessionrestore', 08:47:57 INFO - 'sessionrestore_no_auto_restore']}, 08:47:57 INFO - 'svgr': {'tests': ['tsvgx', 08:47:57 INFO - 'tsvgr_opacity', 08:47:57 INFO - 'tart', 08:47:57 INFO - 'tscrollx', 08:47:57 INFO - 'cart']}, 08:47:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:47:57 INFO - 'tests': ['tsvgx', 08:47:57 INFO - 'tsvgr_opacity', 08:47:57 INFO - 'tart', 08:47:57 INFO - 'tscrollx', 08:47:57 INFO - 'cart']}, 08:47:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:57 INFO - 'tests': ['tp5o']}, 08:47:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:57 INFO - 'talos_options': ['--e10s'], 08:47:57 INFO - 'tests': ['tp5o']}, 08:47:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:57 INFO - 'talos_options': ['--xperf_path', 08:47:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:57 INFO - 'tests': ['tp5n']}, 08:47:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:57 INFO - 'talos_options': ['--e10s', 08:47:57 INFO - '--xperf_path', 08:47:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:57 INFO - 'tests': ['tp5n']}}, 08:47:57 INFO - 'talos.zip': {'path': '', 08:47:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:57 INFO - Running post-action listener: _resource_record_post_action 08:47:57 INFO - ##### 08:47:57 INFO - ##### Running create-virtualenv step. 08:47:57 INFO - ##### 08:47:57 INFO - Running pre-action listener: _resource_record_pre_action 08:47:57 INFO - Running main action method: create_virtualenv 08:47:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:57 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 08:47:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:57 INFO - Using real prefix '/usr' 08:47:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:47:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:47:59 INFO - Installing pip.................done. 08:47:59 INFO - Return code: 0 08:47:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb74a8c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, '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': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', '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 08:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:47:59 INFO - Using env: {'DISPLAY': ':0', 08:47:59 INFO - 'HOME': '/home/cltbld', 08:47:59 INFO - 'LANG': 'en_US.UTF-8', 08:47:59 INFO - 'LANGUAGE': 'en_US:en', 08:47:59 INFO - 'LOGNAME': 'cltbld', 08:47:59 INFO - 'MAIL': '/var/mail/cltbld', 08:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:59 INFO - 'MOZ_NO_REMOTE': '1', 08:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:59 INFO - 'NO_EM_RESTART': '1', 08:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:59 INFO - 'PWD': '/builds/slave/test', 08:47:59 INFO - 'SHELL': '/bin/bash', 08:47:59 INFO - 'SHLVL': '1', 08:47:59 INFO - 'TERM': 'linux', 08:47:59 INFO - 'TMOUT': '86400', 08:47:59 INFO - 'USER': 'cltbld', 08:47:59 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:59 INFO - '_': '/tools/buildbot/bin/python'} 08:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:59 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 08:47:59 INFO - Cleaning up... 08:47:59 INFO - Return code: 0 08:47:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb74a8c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, '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': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', '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 08:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:47:59 INFO - Using env: {'DISPLAY': ':0', 08:47:59 INFO - 'HOME': '/home/cltbld', 08:47:59 INFO - 'LANG': 'en_US.UTF-8', 08:47:59 INFO - 'LANGUAGE': 'en_US:en', 08:47:59 INFO - 'LOGNAME': 'cltbld', 08:47:59 INFO - 'MAIL': '/var/mail/cltbld', 08:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:59 INFO - 'MOZ_NO_REMOTE': '1', 08:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:59 INFO - 'NO_EM_RESTART': '1', 08:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:59 INFO - 'PWD': '/builds/slave/test', 08:47:59 INFO - 'SHELL': '/bin/bash', 08:47:59 INFO - 'SHLVL': '1', 08:47:59 INFO - 'TERM': 'linux', 08:47:59 INFO - 'TMOUT': '86400', 08:47:59 INFO - 'USER': 'cltbld', 08:47:59 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:59 INFO - '_': '/tools/buildbot/bin/python'} 08:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:00 INFO - Downloading/unpacking psutil>=0.7.1 08:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:01 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:48:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:01 INFO - Installing collected packages: psutil 08:48:01 INFO - Running setup.py install for psutil 08:48:02 INFO - building 'psutil._psutil_linux' extension 08:48:02 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 08:48:02 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 08:48:02 INFO - building 'psutil._psutil_posix' extension 08:48:02 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 08:48:02 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 08:48:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:02 INFO - Successfully installed psutil 08:48:02 INFO - Cleaning up... 08:48:02 INFO - Return code: 0 08:48:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:48: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')]} 08:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48: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')]} 08:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb74a8c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, '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': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', '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 08:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:48:02 INFO - Using env: {'DISPLAY': ':0', 08:48:02 INFO - 'HOME': '/home/cltbld', 08:48:02 INFO - 'LANG': 'en_US.UTF-8', 08:48:02 INFO - 'LANGUAGE': 'en_US:en', 08:48:02 INFO - 'LOGNAME': 'cltbld', 08:48:02 INFO - 'MAIL': '/var/mail/cltbld', 08:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:02 INFO - 'MOZ_NO_REMOTE': '1', 08:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:02 INFO - 'NO_EM_RESTART': '1', 08:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:02 INFO - 'PWD': '/builds/slave/test', 08:48:02 INFO - 'SHELL': '/bin/bash', 08:48:02 INFO - 'SHLVL': '1', 08:48:02 INFO - 'TERM': 'linux', 08:48:02 INFO - 'TMOUT': '86400', 08:48:02 INFO - 'USER': 'cltbld', 08:48:02 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:02 INFO - '_': '/tools/buildbot/bin/python'} 08:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:48:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:48:04 INFO - Installing collected packages: mozsystemmonitor 08:48:04 INFO - Running setup.py install for mozsystemmonitor 08:48:04 INFO - Successfully installed mozsystemmonitor 08:48:04 INFO - Cleaning up... 08:48:04 INFO - Return code: 0 08:48:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:04 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')]} 08:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:04 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')]} 08:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:04 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 0x7fb74a8c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, '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': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', '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 08:48:04 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 08:48:04 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 08:48:04 INFO - Using env: {'DISPLAY': ':0', 08:48:04 INFO - 'HOME': '/home/cltbld', 08:48:04 INFO - 'LANG': 'en_US.UTF-8', 08:48:04 INFO - 'LANGUAGE': 'en_US:en', 08:48:04 INFO - 'LOGNAME': 'cltbld', 08:48:04 INFO - 'MAIL': '/var/mail/cltbld', 08:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:04 INFO - 'MOZ_NO_REMOTE': '1', 08:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:04 INFO - 'NO_EM_RESTART': '1', 08:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:04 INFO - 'PWD': '/builds/slave/test', 08:48:04 INFO - 'SHELL': '/bin/bash', 08:48:04 INFO - 'SHLVL': '1', 08:48:04 INFO - 'TERM': 'linux', 08:48:04 INFO - 'TMOUT': '86400', 08:48:04 INFO - 'USER': 'cltbld', 08:48:04 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:04 INFO - '_': '/tools/buildbot/bin/python'} 08:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:06 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 08:48:06 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 08:48:06 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 08:48:06 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 08:48:06 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 08:48:06 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 08:48:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:06 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 08:48:06 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 08:48:06 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 08:48:06 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 08:48:06 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 08:48:06 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 08:48:07 INFO - Downloading docopt-0.6.1.tar.gz 08:48:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:07 INFO - Running setup.py install for blobuploader 08:48:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:07 INFO - Running setup.py install for requests 08:48:07 INFO - Running setup.py install for docopt 08:48:07 INFO - Successfully installed blobuploader requests docopt 08:48:07 INFO - Cleaning up... 08:48:07 INFO - Return code: 0 08:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:07 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 0x7fb74a8c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, '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': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', '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 08:48:07 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 08:48:07 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 08:48:07 INFO - Using env: {'DISPLAY': ':0', 08:48:07 INFO - 'HOME': '/home/cltbld', 08:48:07 INFO - 'LANG': 'en_US.UTF-8', 08:48:07 INFO - 'LANGUAGE': 'en_US:en', 08:48:07 INFO - 'LOGNAME': 'cltbld', 08:48:07 INFO - 'MAIL': '/var/mail/cltbld', 08:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:07 INFO - 'MOZ_NO_REMOTE': '1', 08:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:07 INFO - 'NO_EM_RESTART': '1', 08:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:07 INFO - 'PWD': '/builds/slave/test', 08:48:07 INFO - 'SHELL': '/bin/bash', 08:48:07 INFO - 'SHLVL': '1', 08:48:07 INFO - 'TERM': 'linux', 08:48:07 INFO - 'TMOUT': '86400', 08:48:07 INFO - 'USER': 'cltbld', 08:48:07 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:07 INFO - '_': '/tools/buildbot/bin/python'} 08:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:08 INFO - Running setup.py (path:/tmp/pip-nMUv6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:08 INFO - Running setup.py (path:/tmp/pip-mtiuts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:08 INFO - Running setup.py (path:/tmp/pip-vQsAJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:08 INFO - Running setup.py (path:/tmp/pip-zf3NIJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:08 INFO - Running setup.py (path:/tmp/pip-cRtTCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:08 INFO - Running setup.py (path:/tmp/pip-t2KpHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:08 INFO - Running setup.py (path:/tmp/pip-aHZagk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:08 INFO - Running setup.py (path:/tmp/pip-7FX_2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:08 INFO - Running setup.py (path:/tmp/pip-4tL95s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:08 INFO - Running setup.py (path:/tmp/pip-g0u2tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:08 INFO - Running setup.py (path:/tmp/pip-RCVxsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:08 INFO - Running setup.py (path:/tmp/pip-NIM9YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:08 INFO - Running setup.py (path:/tmp/pip-bU5J_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:08 INFO - Running setup.py (path:/tmp/pip-2Ki2zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:09 INFO - Running setup.py (path:/tmp/pip-fJ5R77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:09 INFO - Running setup.py (path:/tmp/pip-0K3V8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:09 INFO - Running setup.py (path:/tmp/pip-Augqfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:09 INFO - Running setup.py install for manifestparser 08:48:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:09 INFO - Running setup.py install for mozcrash 08:48:09 INFO - Running setup.py install for mozdebug 08:48:09 INFO - Running setup.py install for mozdevice 08:48:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:09 INFO - Running setup.py install for mozfile 08:48:09 INFO - Running setup.py install for mozhttpd 08:48:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:09 INFO - Running setup.py install for mozinfo 08:48:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:09 INFO - Running setup.py install for mozInstall 08:48:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Running setup.py install for mozleak 08:48:10 INFO - Running setup.py install for mozlog 08:48:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Running setup.py install for moznetwork 08:48:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Running setup.py install for mozprocess 08:48:10 INFO - Running setup.py install for mozprofile 08:48:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Running setup.py install for mozrunner 08:48:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:10 INFO - Running setup.py install for mozscreenshot 08:48:10 INFO - Running setup.py install for moztest 08:48:10 INFO - Running setup.py install for mozversion 08:48:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:11 INFO - Cleaning up... 08:48:11 INFO - Return code: 0 08:48:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fb74a8c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, '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': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', '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 08:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 08:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 08:48:11 INFO - Using env: {'DISPLAY': ':0', 08:48:11 INFO - 'HOME': '/home/cltbld', 08:48:11 INFO - 'LANG': 'en_US.UTF-8', 08:48:11 INFO - 'LANGUAGE': 'en_US:en', 08:48:11 INFO - 'LOGNAME': 'cltbld', 08:48:11 INFO - 'MAIL': '/var/mail/cltbld', 08:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:11 INFO - 'MOZ_NO_REMOTE': '1', 08:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:11 INFO - 'NO_EM_RESTART': '1', 08:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:11 INFO - 'PWD': '/builds/slave/test', 08:48:11 INFO - 'SHELL': '/bin/bash', 08:48:11 INFO - 'SHLVL': '1', 08:48:11 INFO - 'TERM': 'linux', 08:48:11 INFO - 'TMOUT': '86400', 08:48:11 INFO - 'USER': 'cltbld', 08:48:11 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:11 INFO - '_': '/tools/buildbot/bin/python'} 08:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:11 INFO - Running setup.py (path:/tmp/pip-e6Qmwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:11 INFO - Running setup.py (path:/tmp/pip-i_flJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:11 INFO - Running setup.py (path:/tmp/pip-h8z1h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:11 INFO - Running setup.py (path:/tmp/pip-rMFc5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:11 INFO - Running setup.py (path:/tmp/pip-UaDORa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:11 INFO - Running setup.py (path:/tmp/pip-6qY93i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:11 INFO - Running setup.py (path:/tmp/pip-P5in6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:11 INFO - Running setup.py (path:/tmp/pip-L4ks4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:11 INFO - Running setup.py (path:/tmp/pip-9Q66Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:11 INFO - Running setup.py (path:/tmp/pip-dY0jEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:11 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)) 08:48:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:11 INFO - Running setup.py (path:/tmp/pip-oy6UCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:12 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)) 08:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:12 INFO - Running setup.py (path:/tmp/pip-0WjuhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:12 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)) 08:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:12 INFO - Running setup.py (path:/tmp/pip-Xs61Vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:12 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)) 08:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:12 INFO - Running setup.py (path:/tmp/pip-XHeZ1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:12 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)) 08:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:12 INFO - Running setup.py (path:/tmp/pip-fKeJR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:12 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)) 08:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:12 INFO - Running setup.py (path:/tmp/pip-p3hmlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:12 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)) 08:48:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:12 INFO - Running setup.py (path:/tmp/pip-9OhTi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:12 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)) 08:48:12 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)) 08:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:12 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)) 08:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:12 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)) 08:48:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:14 INFO - Downloading blessings-1.5.1.tar.gz 08:48:14 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 08:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:14 INFO - Installing collected packages: blessings 08:48:14 INFO - Running setup.py install for blessings 08:48:14 INFO - Successfully installed blessings 08:48:14 INFO - Cleaning up... 08:48:14 INFO - Return code: 0 08:48:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:14 INFO - Reading from file tmpfile_stdout 08:48:14 INFO - Current package versions: 08:48:14 INFO - argparse == 1.2.1 08:48:14 INFO - blessings == 1.5.1 08:48:14 INFO - blobuploader == 1.2.4 08:48:14 INFO - docopt == 0.6.1 08:48:14 INFO - manifestparser == 1.1 08:48:14 INFO - mozInstall == 1.12 08:48:14 INFO - mozcrash == 0.16 08:48:14 INFO - mozdebug == 0.1 08:48:14 INFO - mozdevice == 0.47 08:48:14 INFO - mozfile == 1.2 08:48:14 INFO - mozhttpd == 0.7 08:48:14 INFO - mozinfo == 0.9 08:48:14 INFO - mozleak == 0.1 08:48:14 INFO - mozlog == 3.1 08:48:14 INFO - moznetwork == 0.27 08:48:14 INFO - mozprocess == 0.22 08:48:14 INFO - mozprofile == 0.27 08:48:14 INFO - mozrunner == 6.11 08:48:14 INFO - mozscreenshot == 0.1 08:48:14 INFO - mozsystemmonitor == 0.0 08:48:14 INFO - moztest == 0.7 08:48:14 INFO - mozversion == 1.4 08:48:14 INFO - psutil == 3.1.1 08:48:14 INFO - requests == 1.2.3 08:48:14 INFO - wsgiref == 0.1.2 08:48:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fb74a8c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, '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': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', '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 08:48:14 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 08:48:14 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 08:48:14 INFO - Using env: {'DISPLAY': ':0', 08:48:14 INFO - 'HOME': '/home/cltbld', 08:48:14 INFO - 'LANG': 'en_US.UTF-8', 08:48:14 INFO - 'LANGUAGE': 'en_US:en', 08:48:14 INFO - 'LOGNAME': 'cltbld', 08:48:14 INFO - 'MAIL': '/var/mail/cltbld', 08:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:14 INFO - 'MOZ_NO_REMOTE': '1', 08:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:14 INFO - 'NO_EM_RESTART': '1', 08:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:14 INFO - 'PWD': '/builds/slave/test', 08:48:14 INFO - 'SHELL': '/bin/bash', 08:48:14 INFO - 'SHLVL': '1', 08:48:14 INFO - 'TERM': 'linux', 08:48:14 INFO - 'TMOUT': '86400', 08:48:14 INFO - 'USER': 'cltbld', 08:48:14 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:14 INFO - '_': '/tools/buildbot/bin/python'} 08:48:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:14 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)) 08:48:14 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)) 08:48:14 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)) 08:48:14 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)) 08:48:14 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)) 08:48:14 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)) 08:48:14 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)) 08:48:14 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)) 08:48:14 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)) 08:48:14 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)) 08:48:14 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)) 08:48:14 INFO - Cleaning up... 08:48:14 INFO - Return code: 0 08:48:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb74a8c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, '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': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', '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 08:48:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:48:14 INFO - Using env: {'DISPLAY': ':0', 08:48:14 INFO - 'HOME': '/home/cltbld', 08:48:14 INFO - 'LANG': 'en_US.UTF-8', 08:48:14 INFO - 'LANGUAGE': 'en_US:en', 08:48:14 INFO - 'LOGNAME': 'cltbld', 08:48:14 INFO - 'MAIL': '/var/mail/cltbld', 08:48:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:14 INFO - 'MOZ_NO_REMOTE': '1', 08:48:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:14 INFO - 'NO_EM_RESTART': '1', 08:48:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:14 INFO - 'PWD': '/builds/slave/test', 08:48:14 INFO - 'SHELL': '/bin/bash', 08:48:14 INFO - 'SHLVL': '1', 08:48:14 INFO - 'TERM': 'linux', 08:48:14 INFO - 'TMOUT': '86400', 08:48:14 INFO - 'USER': 'cltbld', 08:48:14 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:48:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:14 INFO - '_': '/tools/buildbot/bin/python'} 08:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:15 INFO - Downloading/unpacking jsonschema 08:48:15 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 08:48:15 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 08:48:15 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 08:48:15 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 08:48:15 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 08:48:15 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 08:48:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:16 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 08:48:16 INFO - Downloading/unpacking functools32 (from jsonschema) 08:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:16 INFO - warning: no files found matching '*.txt' 08:48:16 INFO - no previously-included directories found matching 'build' 08:48:16 INFO - no previously-included directories found matching 'dist' 08:48:16 INFO - no previously-included directories found matching '.git*' 08:48:17 INFO - Installing collected packages: jsonschema, functools32 08:48:17 INFO - Running setup.py install for functools32 08:48:17 INFO - warning: no files found matching '*.txt' 08:48:17 INFO - no previously-included directories found matching 'build' 08:48:17 INFO - no previously-included directories found matching 'dist' 08:48:17 INFO - no previously-included directories found matching '.git*' 08:48:17 INFO - Successfully installed jsonschema functools32 08:48:17 INFO - Cleaning up... 08:48:17 INFO - Return code: 0 08:48:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:48:17 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')]} 08:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 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')]} 08:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:17 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 0x7fb74a8c7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x232c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23fa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, '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': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', '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 08:48:17 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 08:48:17 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 08:48:17 INFO - Using env: {'DISPLAY': ':0', 08:48:17 INFO - 'HOME': '/home/cltbld', 08:48:17 INFO - 'LANG': 'en_US.UTF-8', 08:48:17 INFO - 'LANGUAGE': 'en_US:en', 08:48:17 INFO - 'LOGNAME': 'cltbld', 08:48:17 INFO - 'MAIL': '/var/mail/cltbld', 08:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:17 INFO - 'MOZ_NO_REMOTE': '1', 08:48:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:17 INFO - 'NO_EM_RESTART': '1', 08:48:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:17 INFO - 'PWD': '/builds/slave/test', 08:48:17 INFO - 'SHELL': '/bin/bash', 08:48:17 INFO - 'SHLVL': '1', 08:48:17 INFO - 'TERM': 'linux', 08:48:17 INFO - 'TMOUT': '86400', 08:48:17 INFO - 'USER': 'cltbld', 08:48:17 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:17 INFO - '_': '/tools/buildbot/bin/python'} 08:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:17 INFO - Downloading/unpacking flake8 08:48:17 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 08:48:17 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 08:48:17 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 08:48:17 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 08:48:17 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 08:48:17 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 08:48:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:48:19 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 08:48:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:48:19 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 08:48:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 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 08:48:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:48:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:48:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:48:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:48:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:48:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:48:19 INFO - no previously-included directories found matching 'docs/_build' 08:48:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:48:19 INFO - Running setup.py install for pep8 08:48:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:48:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:48:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:48:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:48:19 INFO - no previously-included directories found matching 'docs/_build' 08:48:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:48:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:48:19 INFO - Cleaning up... 08:48:19 INFO - Return code: 0 08:48:20 INFO - Running post-action listener: _resource_record_post_action 08:48:20 INFO - Running post-action listener: _start_resource_monitoring 08:48:20 INFO - Starting resource monitoring. 08:48:20 INFO - ##### 08:48:20 INFO - ##### Running install step. 08:48:20 INFO - ##### 08:48:20 INFO - Running pre-action listener: _resource_record_pre_action 08:48:20 INFO - Running main action method: install 08:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:20 INFO - Reading from file tmpfile_stdout 08:48:20 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:20 INFO - Reading from file tmpfile_stdout 08:48:20 INFO - Output received: 08:48:20 INFO - Usage: mozinstall [options] installer 08:48:20 INFO - Options: 08:48:20 INFO - -h, --help show this help message and exit 08:48:20 INFO - -d DEST, --destination=DEST 08:48:20 INFO - Directory to install application into. [default: 08:48:20 INFO - "/builds/slave/test"] 08:48:20 INFO - --app=APP Application being installed. [default: firefox] 08:48:20 INFO - mkdir: /builds/slave/test/build/application 08:48:20 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'] 08:48:20 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 08:48:34 INFO - Reading from file tmpfile_stdout 08:48:34 INFO - Output received: 08:48:34 INFO - /builds/slave/test/build/application/firefox/firefox 08:48:34 INFO - Running post-action listener: _resource_record_post_action 08:48:34 INFO - ##### 08:48:34 INFO - ##### Running run-tests step. 08:48:34 INFO - ##### 08:48:34 INFO - Running pre-action listener: _resource_record_pre_action 08:48:34 INFO - Running main action method: run_tests 08:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:34 INFO - Python 2.7.3 08:48:34 INFO - Return code: 0 08:48:34 INFO - grabbing minidump binary from tooltool 08:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:34 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 0x24890b0>, '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 0x2489fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x248a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:34 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 08:48:34 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 08:48:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:34 INFO - Return code: 0 08:48:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:48:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:48:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:48:35 INFO - Return code: 0 08:48:35 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] in /builds/slave/test/build 08:48:35 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost 08:48:35 INFO - Using env: {'DISPLAY': ':0', 08:48:35 INFO - 'HOME': '/home/cltbld', 08:48:35 INFO - 'LANG': 'en_US.UTF-8', 08:48:35 INFO - 'LANGUAGE': 'en_US:en', 08:48:35 INFO - 'LOGNAME': 'cltbld', 08:48:35 INFO - 'MAIL': '/var/mail/cltbld', 08:48:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:35 INFO - 'MOZ_NO_REMOTE': '1', 08:48:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:35 INFO - 'NO_EM_RESTART': '1', 08:48:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:35 INFO - 'PWD': '/builds/slave/test', 08:48:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:35 INFO - 'SHELL': '/bin/bash', 08:48:35 INFO - 'SHLVL': '1', 08:48:35 INFO - 'TERM': 'linux', 08:48:35 INFO - 'TMOUT': '86400', 08:48:35 INFO - 'USER': 'cltbld', 08:48:35 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228', 08:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:35 INFO - '_': '/tools/buildbot/bin/python'} 08:48:35 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] with output_timeout 3600 08:48:35 INFO - mozversion INFO | application_buildid: 20151127082132 08:48:35 INFO - mozversion INFO | application_changeset: 2f801d6ef06489fa9dfbdf160350fcd7e4afbc5d 08:48:35 INFO - mozversion INFO | application_display_name: Nightly 08:48:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:35 INFO - mozversion INFO | application_name: Firefox 08:48:35 INFO - mozversion INFO | application_remotingname: firefox 08:48:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:48:35 INFO - mozversion INFO | application_vendor: Mozilla 08:48:35 INFO - mozversion INFO | application_version: 45.0a1 08:48:35 INFO - mozversion INFO | platform_buildid: 20151127082132 08:48:35 INFO - mozversion INFO | platform_changeset: 2f801d6ef06489fa9dfbdf160350fcd7e4afbc5d 08:48:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:48:35 INFO - mozversion INFO | platform_version: 45.0a1 08:48:35 INFO - 2015-11-27 08:48:35,797 DEBUG : using testdate: 1448642915 08:48:35 INFO - 2015-11-27 08:48:35,797 DEBUG : actual date: 1448642915 08:48:35 INFO - 2015-11-27 08:48:35,845 INFO : starting webserver on 'localhost:59088' 08:48:35 INFO - 2015-11-27 08:48:35,846 INFO : Starting test suite talos-linux64-ix-029 08:48:35 INFO - 2015-11-27 08:48:35,846 INFO : Starting test dromaeo_css 08:48:35 INFO - 2015-11-27 08:48:35,846 DEBUG : operating with platform_type : linux_ 08:48:35 INFO - 2015-11-27 08:48:35,847 INFO : Initialising browser for dromaeo_css test... 08:48:35 INFO - 2015-11-27 08:48:35,863 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi5Hibb/profile http://localhost:59088/getInfo.html 08:48:39 INFO - 2015-11-27 08:48:39,986 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:48:39 INFO - 2015-11-27 08:48:39,986 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:48:39 INFO - 2015-11-27 08:48:39,986 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:48:39 INFO - 2015-11-27 08:48:39,986 DEBUG : BROWSER_OUTPUT: __metrics 08:48:40 INFO - 2015-11-27 08:48:40,075 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:41 INFO - 2015-11-27 08:48:41,633 INFO : Browser initialized. 08:48:41 INFO - 2015-11-27 08:48:41,634 INFO : Running cycle 1/1 for dromaeo_css test... 08:48:41 INFO - 2015-11-27 08:48:41,634 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi5Hibb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:48:53 INFO - 2015-11-27 08:48:53,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 138559488 08:48:53 INFO - 2015-11-27 08:48:53,513 DEBUG : BROWSER_OUTPUT: 08:49:44 INFO - 2015-11-27 08:49:44,562 DEBUG : BROWSER_OUTPUT: 1448642984558 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] 08:51:56 INFO - 2015-11-27 08:51:56,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59088/tests/dromaeo/cssquery-ext.html) 08:51:57 INFO - 2015-11-27 08:51:57,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 253562880 08:51:57 INFO - 2015-11-27 08:51:57,780 DEBUG : BROWSER_OUTPUT: 08:55:00 INFO - 2015-11-27 08:55:00,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/dromaeo/cssquery-ext.html (next: http://localhost:59088/tests/dromaeo/cssquery-jquery.html) 08:55:00 INFO - 2015-11-27 08:55:00,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 219987968 08:55:00 INFO - 2015-11-27 08:55:00,926 DEBUG : BROWSER_OUTPUT: 08:58:02 INFO - 2015-11-27 08:58:02,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59088/tests/dromaeo/cssquery-mootools.html) 08:58:03 INFO - 2015-11-27 08:58:03,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 216784896 08:58:03 INFO - 2015-11-27 08:58:03,456 DEBUG : BROWSER_OUTPUT: 09:01:05 INFO - 2015-11-27 09:01:05,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59088/tests/dromaeo/cssquery-prototype.html) 09:01:06 INFO - 2015-11-27 09:01:06,051 DEBUG : BROWSER_OUTPUT: RSS: Main: 205357056 09:01:06 INFO - 2015-11-27 09:01:06,052 DEBUG : BROWSER_OUTPUT: 09:04:08 INFO - 2015-11-27 09:04:08,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59088/tests/dromaeo/cssquery-yui.html) 09:04:09 INFO - 2015-11-27 09:04:09,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 208199680 09:04:09 INFO - 2015-11-27 09:04:09,398 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-11-27 09:07:12,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/dromaeo/cssquery-yui.html (next: http://localhost:59088/tests/dromaeo/cssquery-dojo.html) 09:07:12 INFO - 2015-11-27 09:07:12,391 DEBUG : BROWSER_OUTPUT: RSS: Main: 254259200 09:07:12 INFO - 2015-11-27 09:07:12,391 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-11-27 09:07:12,391 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:07:12 INFO - 2015-11-27 09:07:12,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:07:12 INFO - 2015-11-27 09:07:12,391 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:07:12 INFO - 2015-11-27 09:07:12,391 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:07:12 INFO - 2015-11-27 09:07:12,391 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2606.973930260697;2682.5439675255216;2699.0148595762553;2713.2809805401566;2720.319920019995;4526.773661316937;4612.031473390588;4615.884602884926;4621.029583787405;4669.603083737878;4531.43357080365;4553.453585569728;4620.792064357103;4648.558386953234;4655.185342565054;4337.154254920292;4358.063016451462;4368.606825385715;4373.497047839507;4400.405945197389;4154.5222299435645;4390.319500477431;4394.582514661118;4429.092036132602;4449.154660614473;4200.789960501963;4263.616274535307;4273.081287523198;4286.549912259199;4302.720323178984;4295.828166873322;4308.332208507686;4325.480942286914;4355.716878402925;4367.475902891641;4128.298189307825;4279.486461624625;4285.507166675841;4301.397804307399;4334.068175342285;4526.773661316954;4534.77326133692;4553.089382123589;4553.977230113861;4566.657500687428;4924.916518365953;4954.826581069645;4957.206846904514;4961.330220420233;4970.90058198834;4968.428630707479;4980.77586508608;4988.176950803113;4993.176125939216;4994.725290109042;4547.8635640930825;4616.053708989649;4616.469106052847;4653.208954477713;4674.602658774008;5108.386993560722;5121.2574176744165;5133.23001549763;5179.948200517946;5187.922181167285;4745.074710431501;4856.417229932431;4863.076015557103;4924.482929292444;4927.482614325516;4854.757262136879;4968.503149685002;4980.825671101494;4981;4989.925151122736;4940.110780059624;4968.850934471971;4972.90054198914;4977.97951419958;5007.574356179693;4946.332245146859;4946.703197808143;4954.950450495521;4956.628252881048;4992.226204938168;4080.571539988318;4173.6661067114555;4178.26880295947;4192;4311.849085282063;3637.3270944875285;3687.3362794697214;3690.2619476104887;3724.0131365188245;3734.8319325630414;4288.120935208275;4293.763842988603;4297.505786834554;4299.54854740254;4341.522432532419;4822.445418776815;4857.514248575114;4929.038837426668;4937.061958227925;4962.230854217602;4284.700070995001;4294.420253265769;4309.095090031066;4313.051128751732;4333.653307735373;4466.843660471868;4487.439070116236;4488.4165058542185;4513.864584062483;4540.091981603692;4585.839495617637;4601.4938356781395;4679.4852566217005;4685.437747470257;4728.692634978715;4982.900341993212;5002.299678045149;5016.799328026838;5021.49785021495;5057.8229761958155;4712.151812673752;4740.3837501124635;4746.857594272177;4751.524847515221;4789.688670236424;4682.0869930364615;4762.928556071731;4787.0904528139545;4813.3983252093485;4940.75296235194;5008.248762685481;5051.949480505295;5052.191649336089;5073.644844860824;5105.412877519133;4899.289603007615;4902.950970490249;4905.043516514388;4910.06708725341;4946.060248552763;4657.347971284091;4724.97637511824;4760.904781904412;4761.785719642694;4893.804247830047;4738.905221895474;4755.405574303212;4755.928661070156;4758.167320718791;4767.856964291077;4861.65968382224;4867.58625516835;4869.732164730974;4870.805167793249;4904.730239836843;4578.359029735906;4667.486576476517;4692.507286734844;4693.296005599187;4780.211265141213 09:07:12 INFO - 2015-11-27 09:07:12,391 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.4495504495504;573.498189084551;574.4083593898283;577.7284676202183;580;27799.722002779967;28428.57357139642;37548.808351290136;37993.240135197346;38077.8096109519;40737.18525629493;41250.58749412505;41285;41288.79355603225;41322.173556528855;7072.080629518156;7660.502067365631;7772.844543109134;7795.922040779605;7803.258690424429;7032.296770322952;7127.786166415016;7135.143782746078;7159.319864612853;10102.14131798798;9984.750381240454;10076.445795481246;10078.193744500422;10084.49577521121;10095.242856785733;9802.754931126743;9912.05835445635;9916;9919.40483570988;9953.502324883726;9839.90160098397;10016.949915250378;10016.94991525045;10017.649382271586;10018.499075046218;36460.27079458396;36703.449448258296;36896.63103368985;36914;37018.44472332917;2751.435955629091;2754.628125203092;2757.9724202757916;2828.844413557274;3296.291297371077;27692;28146.718532814615;28188.436231275464;28375.432491350057;28558.143255702154;3435.7423193260356;3455.58532976042;3476.513288139637;3516.261585067139;3594.19130695594;222473;223075.99999999837;223141;223283;223587;48572;51510.48489515132;52234;52236.47763522392;52271.73864130655;45964;59777;61381.38618613846;61396.693016534635;61430.69284653548;12715.682107947376;12940.870591294155;12951.093423460456;12952;12952.158109722837;8126.39052071097;8257.504549727035;9099.727008189633;9154.267658587298;9595.664151754794;17689.11554422274;17865.821341786675;17930.91034544819;17973.1013449327;17973.550661233574;7373.705051797975;7510.586917719578;7550.697972081165;7575.24247575238;7647.426443016796;836.9874451883227;879.4415546128255;939.300221335096;953.952302384878;1025.497506221946;25775.87112064428;25802.870985644953;26253.73746262513;26784.33039174036;27342.863285683445;903.5301643145659;938.7512309238058;942.8962814090445;1009.4094954451581;1035.0425856083093;12443.93778031104;12635.1787133836;12704.745905081847;12791.552295669608;12798.488060477477;212972;215066;215570;216604;216873;43602.7819860905;43656.56343436588;43668.781656091516;43722.781386092865;43815.56184438179;1190.8511436070492;1193.242291145129;1210.0863847794858;1221.7190046289404;1224.5591587028662;24029.27912162638;24626;24726.258212253662;24847.25458236256;25190.49619007573;38988.80505597454;39294.214115718096;39302.41046384364;39350.2129957405;39371.409428858016;255479;256499;258295;258347;258401;24076.87961560181;24602.876985614956;27555.586666200423;28118.859405702842;28252.293692657026;32652.510212347308;32857.50713739248;33820;33848.830755846066;35675.28649426945;31228.53157202689;31350.05949821509;31876.36247275088;32919.17702057468;33494.49758253579;26472.42622246049;31815.522767158047;34864;35599.82200088983;35879.641203588675;32566.674333257313;32602.34795304128;32918.177045574055;33004.83497582593;33124.33751325008;27161.59257611098;28636.14091577256;28639.42721145607;28721.569176462788;28735.137945861657;22600.434989125402;23405.41486462852;30285;31659.683403165673;32451.513227301137 09:07:12 INFO - 2015-11-27 09:07:12,391 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.74984637366924;314.93543823516154;323.8202797447417;324.61046743907315;325.9967400325997;14740.852591474082;15162.090274583532;15210.315535800888;15655.608609784762;15743.134127622976;14191.432342706305;14192.645183870409;14366.856331436682;14436.350364233609;14826.82373005721;4803.8799030024265;4915.139850526161;4923.236898280772;4924.532169443915;4930.926036109461;4922.4585295617635;4934.555889969902;4941.579965702902;4950;4955.851324460272;3459.5848498180126;3592;4804.639652026094;4975.353204083464;5398.541124004464;5468.781248750045;5496.725163741797;5521.2270282160525;5527.44725527446;5529.0324193266215;2361;2364.8344615876895;3795.6773674237725;4770.594499467549;4784.330193772875;14448.927755361156;14948.775768363483;17666.205020774098;18415.907920460446;19353.322633707754;1800.5948661551176;1873.7002079667188;1891.943241702751;1946.746922900014;2012.0845015517905;12436.875631243753;12449.190802597803;12585;12706.364681765966;12776.61670149897;1696.720041193214;1708.9914550427168;1747.4670225581192;1776.9378071767555;1833.0926191535143;55091;55414.44585554174;56136.87726245493;56314.43685563133;56329.43670563283;9034.45793252407;9139;9169.35814492979;9258.95370523143;9270.814583708288;11852.940735296268;11876.228045177037;11876.940615296868;11882.049436045096;11883.762324753456;6653.767118150939;6664.166979127609;6687.030380594787;6740.730370785113;6772.492063095287;6323.43089121972;6360.618362898241;6383.840403989938;6391.392817682313;6411.551191416556;5594.608377413542;5652.208690783294;5655.830325090254;5665.631733937281;5685.6304340218585;1560.4928398270608;1577.242923396776;1608.5817687401127;1611.395726602524;1616.9838301616833;667.462692532516;808.9029316481942;820.5445977482555;834.7245409015011;837.6523742646733;15686.843131568538;15810.683786324209;15906.204689765696;15946.122963237134;16299.511014669579;826.4586695714316;840.7813968368268;871.0897112517434;878.1262643669462;893.821235752852;7675.616219189018;8975.37172397939;9207.723768286962;9263.629454821732;9332.673356432493;529542;530046;530360;548238;558934;69457;71425.64287178635;72303.2769672307;72540.63729681318;73397.26602734011;1067.5089458849016;1082.9187810914214;1090.0353187429182;1092.5465931638282;1093.3767752381225;14630.122192668474;14696.338664760326;14707.92646036763;14808.407663693763;15210.391584336503;33734;33870;33920.321593568486;34185.82907085449;34223.828880855435;44692;44695.32957005582;44724.77637611791;45638.31542526931;48247;8157.75526734199;8158.551279679675;8283.668653253802;8301.667933282843;8831.293496520391;15738.291776870297;15800.288986995844;15932.601684957968;16055;16479.752803707714;9333.553299238629;12908.41912113976;13325.200487970753;13602.183868967893;14097.436102556194;12505.624831255076;12530.874691252971;12549.435275412447;12677.112602118132;12965.740685186433;13010.544630937871;13068.281244531261;13078.673033174247;13313.933430332787;13338.26639534835;8011.3590912728005;8162.7143049992965;8608.09614990417;8684.913150868411;8704.738857834274;12701.36493175319;13023.088383813041;13077.803832942323;13418.93290533541;13465.730685386434 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1332.5269529317086;1373.7321222361638;1399.3073428652817;1510.09394363382;1587.6824635072987;5718.685472299022;6344.302126766058;6524.836879078025;6528.31452697467;6534.281229064805;6547.34526547345;6666.333366663332;6670.366315200048;6683.899741503881;6684.866302673956;1676.9916150419292;1695.0592421206225;1697.2277613685744;1971.2509246486316;2004.7694515130727;1940.922363105474;1997.5805080933021;1998.1407994562333;1998.7601487821482;1999.7000449932555;1902.8097190281;1929.7491326127583;1931.0537836460173;1947.9902600486978;1949.512621844539;1939.85451091168;1960.127743154297;1964.6463636545416;1965.3317871923543;1965.665836807739;1940.194819150065;1975.1111999600093;1978.2186036515495;1984.2459865251112;1986.3047933223402;6490.2536208335705;6559.2128944526485;6559.770408035696;6562.770303039419;6563.967180164116;3556.3598552260582;3614.313280476701;3640.3993341098685;3647.0335361129323;3647.215848592565;2520;2569.40903592173;2580.4839032193636;2631.1317265302405;2644.867756612162;746.8580969615809;761.6077719974218;804.1676864445329;886.1138861138861;941.2140862379921;8638.308935285162;8678.566071696454;8686.435381700168;8692.739217823411;8694.478331300143;3511.2099777549847;3516.9648303517147;3522.0314413536485;3544.379733546619;3553.680168784822;7631.923680763232;7682.078150621961;7682.347000504908;7682.692692292358;7686.9231307686205;3878.0111071676542;3879.6120387960977;3879.631435013669;3879.689624830007;3887.2225554889137;3504.176518518197;3505.772124811879;3525.1715846775987;3530.629283925151;3531.8168413581225;2801.2016575275948;2839.389531250791;3125.5311703244697;3138.325260069096;3154.794938329001;881.1232823340816;901.4140808474544;902.8104098139333;925.6251218256482;985.093713783321;912.7124955638952;921.3274309753783;963.325672029582;971.3928794503436;1157.3923690062784;6304.558680892385;6330.651814150266;6359;6370.331115232926;6371.33101024395;1007.09361574582;1071.4856868703066;1097.237419993097;1102.9062529685066;1127.8533790607169;5049.722265275372;5079.720615366116;5104.821331253388;5105.106606343875;5168.043911876315;7801.726939557088;7895.6052197391045;7911.802204944807;7943.364530837519;7957.840843183104;7655.387568994467;7848;7855.293023627786;7858.096318923397;7892.092409372881;6288.937110628926;6306.1171435998995;6308.684565771785;6344.302126766052;6353.841153971095;6070.332263451105;6146.569740118149;6151.200343955257;6152.78465253714;6161.44546990773;7113.786586402416;7172.354488096096;7182.96408517954;7218.89171662415;7238.23998480152;7172.677229524788;7231.819204519929;7333.046703928455;7340.669669864976;7355.117385913724;5387.191921211693;5395.892082158413;5433.130699088127;5453.754581043783;5462.8907421850545;6189.04069869171;6226.40849119333;6238.095476155841;6244.1570387997035;6254.749050189889;5275.076861549291;6035.36628653985;6151.50787936955;6221.688915554295;6305.1172835803945;5303.496167864047;5912.290525137011;5938.287405511366;5964.582479226413;6034.306054803754;6091.543134264859;6176.197094377702;6202.2867370253;6211.9068213975925;6216.2540495139065;5660.85847853807;5664.745086471036;5674.57440691958;5680.318361796611;5683.488486036276;5880.088586269135;5900.498457631149;5900.911486327623;5914.67469289176;5915.70421478933 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: |4;prototype.html;289.9811512251703;290.8167854251821;293.96913324100956;294.5390463923959;295.3030847200606;5230.823064810415;5255.237990491381;5318.867028324294;5345.305110335651;5377.435369286218;5241.764120614572;5299.814506492274;5314.521693047625;5315.0698627740185;5317.5480084192795;4094.8362065517344;4114.218298523286;4114.7119701620895;4116.300228961069;4117.526484454281;3831.63599458051;3932.5674175840636;3992.061865461614;4099.856505022325;4102.774347410891;4044.1911617676437;4049.8785036448953;4050.5544390117066;4058.330375488056;4078.5717499662555;3819.5034645495907;3948.190620922704;4063.14673918476;4067.8169482373364;4068.023674318157;3386.7629265951145;3450.6376830432696;3459.4637831136215;3459.705924996378;3460.0311912664492;5005.049040682259;5009.849704508871;5011.198208286657;5016.122178618727;5019.19692849146;4538.52345503724;4542.386777785023;4547.067851090518;4549.363089167519;4549.567791059844;5381.165919282517;5442.102053161224;5455.345358556959;5456.045192091407;5458.344998600153;3853.0560012796764;3853.7687738735485;3854.6338097880657;3858.054776579728;3858.575556688762;5791.073428251501;5850.385709500526;5853.970730146365;5869.413058694139;5869.413058694139;3893.201893611803;3894.7078969077434;3898.8830335089992;3899.200663863901;3901.297766402075;3952.347862602696;3953.525576930729;3955.9011024724036;3959.5050618672667;3961.861334853324;4506.594406503365;4594.471635761864;4634.0036892068365;4636.095961287584;4641.396618439581;5569.944300557024;5570.108782594765;5571.498565129077;5575.888482230333;5587.05020146576;1391.679913619873;1426.522115091456;1426.657602175491;1426.7360538300447;1426.8002479652857;950.7432993091827;952.2096659772373;955.1880901233895;965.7778710896533;976.0776066616979;4901.950980490149;4914.8034078637165;4915.606751459874;4919.581835543947;4924.901501969941;5790.305163380422;5804.448577385142;5808.535317174616;5808.676529388278;5812.912806307909;4906.828261010847;4908.754562271872;4909.214525675875;4911.45973942866;4917.065757506062;2995.655499617572;3024.2590565311198;3095.721385075354;3126.5935428394164;3129.796563223383;5412.621116521806;5443.537299329601;5534.557235421156;5542.307211598551;5547.916781248285;5960;5968.1644569760265;5995.850103747354;6010.278766548042;6014.977453832859;5493.890122197614;5521.889562208814;5529.889402212014;5534.916976245359;5542.39033706292;5690.77236910519;5837.949169149594;5868.413158684098;5869.383714709894;5875.6474611523445;5711.914321285101;5712.714364281686;5715.31416230055;5718.714064296852;5719.3136823581435;5529.778808847601;5536.390996990247;5542.334919809648;5543.390227074938;5545.029619816597;3829.9234015320094;3945.467361906106;3980.184062267286;3981.462502562117;3983.24318379507;5789.942100579109;5818.33089194748;5818.76724931015;5820.73806678692;5822.301323841166;5591.077472217039;5598.244237027949;5605.523530499953;5608.242887210175;5616.85957851057;5602.803901863415;5607.327120745536;5615.466530679579;5616.241807355955;5617.466340697627;5370.462953704755;5493.203485494501;5495.560355171657;5500.312460942382;5503.972480137573;5626.2967129108865;5631.239782629293;5639.379668236573;5640.85897852557;5647.435256474319;5508.173773933942;5514.36584792754;5514.5864060194845;5517.310336207974;5519.39286678457 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: |5;yui.html;689.3554526517706;766.088354857719;770.214381331042;773.7833406646138;794.213728408875;10534.789304213911;10776.353418794877;10785.784284314328;10798.2441229114;10807.729806754825;10099.343542669722;10625.46872656366;10759.569617215302;10762;11523.19337646365;757.5076200469683;772.5480593852603;773.2036002916976;773.798812308801;774.0943096577018;767.4282659418741;773.8065483629093;774.0131332551015;774.0788461730523;774.4346626962292;814.0150417994234;819.1603606303556;821.1870248454018;821.2116368286452;821.5399376349263;811.6144831205189;813.9715109971153;815.9347252219808;816.3346872299057;816.3673153306175;601.3986013986014;601.7081715368043;602.1990752299475;602.9005214139662;602.9095635654687;10631.893681063168;10772.192085593611;10790.67627971162;10799.352038877692;10801.5679372825;11426.37154956477;11612;11939.22395044328;12065.879341206562;12164.02687784975;9082.77293067672;9326.813463730756;9327.860082098774;10038;10163.441010744406;3207.9679203208134;3221.742260619168;3243.2702641905385;3278.50822376643;3356.8992930212135;34245.486317705254;34562.308753824786;41659.7917010413;41896.58103418957;42622.78688606537;7493.925060749323;9162.587683554257;9219.953900230455;9440.29197810167;9466.148046675695;14149.08030977983;14311.35598898052;14317;14321.212333321768;16630.83369166317;6398.744050237939;6512.706928188243;6546.476281897437;6674.966625166843;6715.664216789239;3644.4715516249994;3664.5419322584676;3725.4784330193793;3727.8881633551036;3759.2293579816073;2674.5453272943646;2704.080612591689;2705.4318593095277;2705.4318593095277;2706.526357887362;479.23561918739557;482.5584590100019;483.789551545079;495.01739047989713;499.910016197088;529.2035486592654;587.4800801290803;609.3540846702509;617.2130533569645;635.4344633276388;7129.714811407589;7598.800763150788;7625;7627.275408836263;7643.121041080347;537.9112446446371;565.8019693107461;580.077676494376;599.3598199929319;606.2300877885061;3419.9487007694906;3569.1077230692326;3580.534530511017;3589.748717589796;3632.146445585285;50043.74978125086;50911.74544127256;51040;51275.23087153696;51400.74299628478;45516.772416137705;45611.54388456073;45854.54145458503;46164.07671846544;46209;35441.46837797435;38604.80697596494;43015;45961.540384595726;46122.07755844932;7935.404844636791;7953.403494737802;8038.437309388287;8145.592720364077;8172.5913704315735;31643;32255;32479.02562923116;32634.51048234231;33046;38550.807245964716;38875.416868746426;39224.2155156901;40159;40729.1854162921;8861.556922153995;9581.281403894875;9932.900670993487;9985.201183905416;10085.949570252102;11091.667249982513;11160.609378671708;11536.82694759596;12243.20419172751;12259.141860069709;9426.24590032782;9876.555554999899;10362.481875906326;10394.948025259826;10739.838902416313;11036.724081897695;11203.551857925917;11267.549298027987;11559.653210403701;11584.652460426201;10409.895901040893;10649.201309901633;10711.00359152932;11092.168087393316;11101.056410205223;8811.427257228259;8908.710275922844;9023.759817079024;9190.724278271662;9289.256859451092;8810.647574096964;9429.952850235704;9481.241500680067;9494.145526902612;9542.33203675736 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,965 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: __startTimestamp1448644032384__endTimestamp 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:07:12 INFO - 2015-11-27 09:07:12,392 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:07:12 INFO - 2015-11-27 09:07:12,393 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-11-27 09:07:12,393 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4595.40 Median:4685.44 stddev:466.09 (9.9%) stddev-sans-first:440.64 09:07:12 INFO - 2015-11-27 09:07:12,393 DEBUG : BROWSER_OUTPUT: Values: 2607.0 2682.5 2699.0 2713.3 2720.3 4526.8 4612.0 4615.9 4621.0 4669.6 4531.4 4553.5 4620.8 4648.6 4655.2 4337.2 4358.1 4368.6 4373.5 4400.4 4154.5 4390.3 4394.6 4429.1 4449.2 4200.8 4263.6 4273.1 4286.5 4302.7 4295.8 4308.3 4325.5 4355.7 4367.5 4128.3 4279.5 4285.5 4301.4 4334.1 4526.8 4534.8 4553.1 4554.0 4566.7 4924.9 4954.8 4957.2 4961.3 4970.9 4968.4 4980.8 4988.2 4993.2 4994.7 4547.9 4616.1 4616.5 4653.2 4674.6 5108.4 5121.3 5133.2 5179.9 5187.9 4745.1 4856.4 4863.1 4924.5 4927.5 4854.8 4968.5 4980.8 4981.0 4989.9 4940.1 4968.9 4972.9 4978.0 5007.6 4946.3 4946.7 4955.0 4956.6 4992.2 4080.6 4173.7 4178.3 4192.0 4311.8 3637.3 3687.3 3690.3 3724.0 3734.8 4288.1 4293.8 4297.5 4299.5 4341.5 4822.4 4857.5 4929.0 4937.1 4962.2 4284.7 4294.4 4309.1 4313.1 4333.7 4466.8 4487.4 4488.4 4513.9 4540.1 4585.8 4601.5 4679.5 4685.4 4728.7 4982.9 5002.3 5016.8 5021.5 5057.8 4712.2 4740.4 4746.9 4751.5 4789.7 4682.1 4762.9 4787.1 4813.4 4940.8 5008.2 5051.9 5052.2 5073.6 5105.4 4899.3 4903.0 4905.0 4910.1 4946.1 4657.3 4725.0 4760.9 4761.8 4893.8 4738.9 4755.4 4755.9 4758.2 4767.9 4861.7 4867.6 4869.7 4870.8 4904.7 4578.4 4667.5 4692.5 4693.3 4780.2 09:07:12 INFO - 2015-11-27 09:07:12,393 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-11-27 09:07:12,393 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39147.69 Median:32755.01 stddev:60488.38 (184.7%) stddev-sans-first:60588.64 09:07:12 INFO - 2015-11-27 09:07:12,393 DEBUG : BROWSER_OUTPUT: Values: 550.4 573.5 574.4 577.7 580.0 27799.7 28428.6 37548.8 37993.2 38077.8 40737.2 41250.6 41285.0 41288.8 41322.2 7072.1 7660.5 7772.8 7795.9 7803.3 7032.3 7127.8 7135.1 7159.3 10102.1 9984.8 10076.4 10078.2 10084.5 10095.2 9802.8 9912.1 9916.0 9919.4 9953.5 9839.9 10016.9 10016.9 10017.6 10018.5 36460.3 36703.4 36896.6 36914.0 37018.4 2751.4 2754.6 2758.0 2828.8 3296.3 27692.0 28146.7 28188.4 28375.4 28558.1 3435.7 3455.6 3476.5 3516.3 3594.2 222473.0 223076.0 223141.0 223283.0 223587.0 48572.0 51510.5 52234.0 52236.5 52271.7 45964.0 59777.0 61381.4 61396.7 61430.7 12715.7 12940.9 12951.1 12952.0 12952.2 8126.4 8257.5 9099.7 9154.3 9595.7 17689.1 17865.8 17930.9 17973.1 17973.6 7373.7 7510.6 7550.7 7575.2 7647.4 837.0 879.4 939.3 954.0 1025.5 25775.9 25802.9 26253.7 26784.3 27342.9 903.5 938.8 942.9 1009.4 1035.0 12443.9 12635.2 12704.7 12791.6 12798.5 212972.0 215066.0 215570.0 216604.0 216873.0 43602.8 43656.6 43668.8 43722.8 43815.6 1190.9 1193.2 1210.1 1221.7 1224.6 24029.3 24626.0 24726.3 24847.3 25190.5 38988.8 39294.2 39302.4 39350.2 39371.4 255479.0 256499.0 258295.0 258347.0 258401.0 24076.9 24602.9 27555.6 28118.9 28252.3 32652.5 32857.5 33820.0 33848.8 35675.3 31228.5 31350.1 31876.4 32919.2 33494.5 26472.4 31815.5 34864.0 35599.8 35879.6 32566.7 32602.3 32918.2 33004.8 33124.3 27161.6 28636.1 28639.4 28721.6 28735.1 22600.4 23405.4 30285.0 31659.7 32451.5 09:07:12 INFO - 2015-11-27 09:07:12,393 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27818.58 Median:18841.71 stddev:88083.21 (467.5%) stddev-sans-first:88306.09 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: Values: 310.7 314.9 323.8 324.6 326.0 14740.9 15162.1 15210.3 15655.6 15743.1 14191.4 14192.6 14366.9 14436.4 14826.8 4803.9 4915.1 4923.2 4924.5 4930.9 4922.5 4934.6 4941.6 4950.0 4955.9 3459.6 3592.0 4804.6 4975.4 5398.5 5468.8 5496.7 5521.2 5527.4 5529.0 2361.0 2364.8 3795.7 4770.6 4784.3 14448.9 14948.8 17666.2 18415.9 19353.3 1800.6 1873.7 1891.9 1946.7 2012.1 12436.9 12449.2 12585.0 12706.4 12776.6 1696.7 1709.0 1747.5 1776.9 1833.1 55091.0 55414.4 56136.9 56314.4 56329.4 9034.5 9139.0 9169.4 9259.0 9270.8 11852.9 11876.2 11876.9 11882.0 11883.8 6653.8 6664.2 6687.0 6740.7 6772.5 6323.4 6360.6 6383.8 6391.4 6411.6 5594.6 5652.2 5655.8 5665.6 5685.6 1560.5 1577.2 1608.6 1611.4 1617.0 667.5 808.9 820.5 834.7 837.7 15686.8 15810.7 15906.2 15946.1 16299.5 826.5 840.8 871.1 878.1 893.8 7675.6 8975.4 9207.7 9263.6 9332.7 529542.0 530046.0 530360.0 548238.0 558934.0 69457.0 71425.6 72303.3 72540.6 73397.3 1067.5 1082.9 1090.0 1092.5 1093.4 14630.1 14696.3 14707.9 14808.4 15210.4 33734.0 33870.0 33920.3 34185.8 34223.8 44692.0 44695.3 44724.8 45638.3 48247.0 8157.8 8158.6 8283.7 8301.7 8831.3 15738.3 15800.3 15932.6 16055.0 16479.8 9333.6 12908.4 13325.2 13602.2 14097.4 12505.6 12530.9 12549.4 12677.1 12965.7 13010.5 13068.3 13078.7 13313.9 13338.3 8011.4 8162.7 8608.1 8684.9 8704.7 12701.4 13023.1 13077.8 13418.9 13465.7 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4619.09 Median:5951.43 stddev:2378.90 (40.0%) stddev-sans-first:2372.74 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: Values: 1332.5 1373.7 1399.3 1510.1 1587.7 5718.7 6344.3 6524.8 6528.3 6534.3 6547.3 6666.3 6670.4 6683.9 6684.9 1677.0 1695.1 1697.2 1971.3 2004.8 1940.9 1997.6 1998.1 1998.8 1999.7 1902.8 1929.7 1931.1 1948.0 1949.5 1939.9 1960.1 1964.6 1965.3 1965.7 1940.2 1975.1 1978.2 1984.2 1986.3 6490.3 6559.2 6559.8 6562.8 6564.0 3556.4 3614.3 3640.4 3647.0 3647.2 2520.0 2569.4 2580.5 2631.1 2644.9 746.9 761.6 804.2 886.1 941.2 8638.3 8678.6 8686.4 8692.7 8694.5 3511.2 3517.0 3522.0 3544.4 3553.7 7631.9 7682.1 7682.3 7682.7 7686.9 3878.0 3879.6 3879.6 3879.7 3887.2 3504.2 3505.8 3525.2 3530.6 3531.8 2801.2 2839.4 3125.5 3138.3 3154.8 881.1 901.4 902.8 925.6 985.1 912.7 921.3 963.3 971.4 1157.4 6304.6 6330.7 6359.0 6370.3 6371.3 1007.1 1071.5 1097.2 1102.9 1127.9 5049.7 5079.7 5104.8 5105.1 5168.0 7801.7 7895.6 7911.8 7943.4 7957.8 7655.4 7848.0 7855.3 7858.1 7892.1 6288.9 6306.1 6308.7 6344.3 6353.8 6070.3 6146.6 6151.2 6152.8 6161.4 7113.8 7172.4 7183.0 7218.9 7238.2 7172.7 7231.8 7333.0 7340.7 7355.1 5387.2 5395.9 5433.1 5453.8 5462.9 6189.0 6226.4 6238.1 6244.2 6254.7 5275.1 6035.4 6151.5 6221.7 6305.1 5303.5 5912.3 5938.3 5964.6 6034.3 6091.5 6176.2 6202.3 6211.9 6216.3 5660.9 5664.7 5674.6 5680.3 5683.5 5880.1 5900.5 5900.9 5914.7 5915.7 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4611.12 Median:5316.31 stddev:1380.30 (26.0%) stddev-sans-first:1345.53 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: Values: 290.0 290.8 294.0 294.5 295.3 5230.8 5255.2 5318.9 5345.3 5377.4 5241.8 5299.8 5314.5 5315.1 5317.5 4094.8 4114.2 4114.7 4116.3 4117.5 3831.6 3932.6 3992.1 4099.9 4102.8 4044.2 4049.9 4050.6 4058.3 4078.6 3819.5 3948.2 4063.1 4067.8 4068.0 3386.8 3450.6 3459.5 3459.7 3460.0 5005.0 5009.8 5011.2 5016.1 5019.2 4538.5 4542.4 4547.1 4549.4 4549.6 5381.2 5442.1 5455.3 5456.0 5458.3 3853.1 3853.8 3854.6 3858.1 3858.6 5791.1 5850.4 5854.0 5869.4 5869.4 3893.2 3894.7 3898.9 3899.2 3901.3 3952.3 3953.5 3955.9 3959.5 3961.9 4506.6 4594.5 4634.0 4636.1 4641.4 5569.9 5570.1 5571.5 5575.9 5587.1 1391.7 1426.5 1426.7 1426.7 1426.8 950.7 952.2 955.2 965.8 976.1 4902.0 4914.8 4915.6 4919.6 4924.9 5790.3 5804.4 5808.5 5808.7 5812.9 4906.8 4908.8 4909.2 4911.5 4917.1 2995.7 3024.3 3095.7 3126.6 3129.8 5412.6 5443.5 5534.6 5542.3 5547.9 5960.0 5968.2 5995.9 6010.3 6015.0 5493.9 5521.9 5529.9 5534.9 5542.4 5690.8 5837.9 5868.4 5869.4 5875.6 5711.9 5712.7 5715.3 5718.7 5719.3 5529.8 5536.4 5542.3 5543.4 5545.0 3829.9 3945.5 3980.2 3981.5 3983.2 5789.9 5818.3 5818.8 5820.7 5822.3 5591.1 5598.2 5605.5 5608.2 5616.9 5602.8 5607.3 5615.5 5616.2 5617.5 5370.5 5493.2 5495.6 5500.3 5504.0 5626.3 5631.2 5639.4 5640.9 5647.4 5508.2 5514.4 5514.6 5517.3 5519.4 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-11-27 09:07:12,394 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12236.96 Median:23344.12 stddev:14045.42 (60.2%) stddev-sans-first:14058.05 09:07:12 INFO - 2015-11-27 09:07:12,395 DEBUG : BROWSER_OUTPUT: Values: 689.4 766.1 770.2 773.8 794.2 10534.8 10776.4 10785.8 10798.2 10807.7 10099.3 10625.5 10759.6 10762.0 11523.2 757.5 772.5 773.2 773.8 774.1 767.4 773.8 774.0 774.1 774.4 814.0 819.2 821.2 821.2 821.5 811.6 814.0 815.9 816.3 816.4 601.4 601.7 602.2 602.9 602.9 10631.9 10772.2 10790.7 10799.4 10801.6 11426.4 11612.0 11939.2 12065.9 12164.0 9082.8 9326.8 9327.9 10038.0 10163.4 3208.0 3221.7 3243.3 3278.5 3356.9 34245.5 34562.3 41659.8 41896.6 42622.8 7493.9 9162.6 9220.0 9440.3 9466.1 14149.1 14311.4 14317.0 14321.2 16630.8 6398.7 6512.7 6546.5 6675.0 6715.7 3644.5 3664.5 3725.5 3727.9 3759.2 2674.5 2704.1 2705.4 2705.4 2706.5 479.2 482.6 483.8 495.0 499.9 529.2 587.5 609.4 617.2 635.4 7129.7 7598.8 7625.0 7627.3 7643.1 537.9 565.8 580.1 599.4 606.2 3419.9 3569.1 3580.5 3589.7 3632.1 50043.7 50911.7 51040.0 51275.2 51400.7 45516.8 45611.5 45854.5 46164.1 46209.0 35441.5 38604.8 43015.0 45961.5 46122.1 7935.4 7953.4 8038.4 8145.6 8172.6 31643.0 32255.0 32479.0 32634.5 33046.0 38550.8 38875.4 39224.2 40159.0 40729.2 8861.6 9581.3 9932.9 9985.2 10085.9 11091.7 11160.6 11536.8 12243.2 12259.1 9426.2 9876.6 10362.5 10394.9 10739.8 11036.7 11203.6 11267.5 11559.7 11584.7 10409.9 10649.2 10711.0 11092.2 11101.1 8811.4 8908.7 9023.8 9190.7 9289.3 8810.6 9430.0 9481.2 9494.1 9542.3 09:07:12 INFO - 2015-11-27 09:07:12,396 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:07:12 INFO - 2015-11-27 09:07:12,396 DEBUG : BROWSER_OUTPUT: 09:07:13 INFO - 2015-11-27 09:07:13,135 INFO : Browser exited with error code: 0 09:07:13 INFO - 2015-11-27 09:07:13,156 INFO : Completed test dromaeo_css (00:18:37) 09:07:13 INFO - 2015-11-27 09:07:13,156 INFO : Starting test kraken 09:07:13 INFO - 2015-11-27 09:07:13,156 DEBUG : operating with platform_type : linux_ 09:07:13 INFO - 2015-11-27 09:07:13,156 INFO : Initialising browser for kraken test... 09:07:13 INFO - 2015-11-27 09:07:13,162 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr2hsOv/profile http://localhost:59088/getInfo.html 09:07:17 INFO - 2015-11-27 09:07:17,222 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:07:17 INFO - 2015-11-27 09:07:17,223 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:07:17 INFO - 2015-11-27 09:07:17,223 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:07:17 INFO - 2015-11-27 09:07:17,223 DEBUG : BROWSER_OUTPUT: __metrics 09:07:17 INFO - 2015-11-27 09:07:17,339 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:18 INFO - 2015-11-27 09:07:18,531 INFO : Browser initialized. 09:07:18 INFO - 2015-11-27 09:07:18,532 INFO : Running cycle 1/1 for kraken test... 09:07:18 INFO - 2015-11-27 09:07:18,532 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr2hsOv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:07:30 INFO - 2015-11-27 09:07:30,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 139014144 09:07:30 INFO - 2015-11-27 09:07:30,375 DEBUG : BROWSER_OUTPUT: 09:07:32 INFO - 2015-11-27 09:07:32,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59088/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:33 INFO - 2015-11-27 09:07:33,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 175763456 09:07:33 INFO - 2015-11-27 09:07:33,551 DEBUG : BROWSER_OUTPUT: 09:07:36 INFO - 2015-11-27 09:07:36,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59088/tests/kraken/driver.html?testName=audio-dft) 09:07:36 INFO - 2015-11-27 09:07:36,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 166191104 09:07:36 INFO - 2015-11-27 09:07:36,849 DEBUG : BROWSER_OUTPUT: 09:07:39 INFO - 2015-11-27 09:07:39,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59088/tests/kraken/driver.html?testName=audio-fft) 09:07:40 INFO - 2015-11-27 09:07:40,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 150810624 09:07:40 INFO - 2015-11-27 09:07:40,408 DEBUG : BROWSER_OUTPUT: 09:07:42 INFO - 2015-11-27 09:07:42,465 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59088/tests/kraken/driver.html?testName=audio-oscillator) 09:07:43 INFO - 2015-11-27 09:07:43,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 153526272 09:07:43 INFO - 2015-11-27 09:07:43,039 DEBUG : BROWSER_OUTPUT: 09:07:45 INFO - 2015-11-27 09:07:45,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59088/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:07:45 INFO - 2015-11-27 09:07:45,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 153812992 09:07:45 INFO - 2015-11-27 09:07:45,835 DEBUG : BROWSER_OUTPUT: 09:07:48 INFO - 2015-11-27 09:07:48,798 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59088/tests/kraken/driver.html?testName=imaging-darkroom) 09:07:49 INFO - 2015-11-27 09:07:49,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 153927680 09:07:49 INFO - 2015-11-27 09:07:49,379 DEBUG : BROWSER_OUTPUT: 09:07:52 INFO - 2015-11-27 09:07:52,764 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59088/tests/kraken/driver.html?testName=imaging-desaturate) 09:07:53 INFO - 2015-11-27 09:07:53,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 156733440 09:07:53 INFO - 2015-11-27 09:07:53,345 DEBUG : BROWSER_OUTPUT: 09:07:56 INFO - 2015-11-27 09:07:56,154 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59088/tests/kraken/driver.html?testName=json-parse-financial) 09:07:56 INFO - 2015-11-27 09:07:56,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 156078080 09:07:56 INFO - 2015-11-27 09:07:56,735 DEBUG : BROWSER_OUTPUT: 09:07:58 INFO - 2015-11-27 09:07:58,486 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59088/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:07:59 INFO - 2015-11-27 09:07:59,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 162566144 09:07:59 INFO - 2015-11-27 09:07:59,047 DEBUG : BROWSER_OUTPUT: 09:08:00 INFO - 2015-11-27 09:08:00,949 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59088/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:01 INFO - 2015-11-27 09:08:01,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 162254848 09:08:01 INFO - 2015-11-27 09:08:01,551 DEBUG : BROWSER_OUTPUT: 09:08:03 INFO - 2015-11-27 09:08:03,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59088/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:04 INFO - 2015-11-27 09:08:04,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 173588480 09:08:04 INFO - 2015-11-27 09:08:04,306 DEBUG : BROWSER_OUTPUT: 09:08:06 INFO - 2015-11-27 09:08:06,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:07 INFO - 2015-11-27 09:08:07,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 180031488 09:08:07 INFO - 2015-11-27 09:08:07,451 DEBUG : BROWSER_OUTPUT: 09:08:10 INFO - 2015-11-27 09:08:10,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:10 INFO - 2015-11-27 09:08:10,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 178139136 09:08:10 INFO - 2015-11-27 09:08:10,665 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59088/tests/kraken/driver.html?testName=ai-astar) 09:08:12 INFO - 2015-11-27 09:08:12,656 DEBUG : BROWSER_OUTPUT: RSS: Main: 235720704 09:08:12 INFO - 2015-11-27 09:08:12,657 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,657 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:08:12 INFO - 2015-11-27 09:08:12,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:08:12 INFO - 2015-11-27 09:08:12,657 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:08:12 INFO - 2015-11-27 09:08:12,657 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:08:12 INFO - 2015-11-27 09:08:12,657 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;106;112;113;112;103;112;112;105 09:08:12 INFO - 2015-11-27 09:08:12,657 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;138;150;173;133;151;150;131;166;132 09:08:12 INFO - 2015-11-27 09:08:12,657 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;162;161;160;160;159;161;161;161 09:08:12 INFO - 2015-11-27 09:08:12,657 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;79;97;72;72;71;100;92;73 09:08:12 INFO - 2015-11-27 09:08:12,658 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;131;94;95;94;132;94;95;124 09:08:12 INFO - 2015-11-27 09:08:12,658 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;110;109;109;109;109 09:08:12 INFO - 2015-11-27 09:08:12,658 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;147;146;146;147;150;146 09:08:12 INFO - 2015-11-27 09:08:12,658 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;94;96;95;95;95;95;95;95;96;96 09:08:12 INFO - 2015-11-27 09:08:12,658 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;73;73;71;72;72;71;79;69;75 09:08:12 INFO - 2015-11-27 09:08:12,658 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;71;69;70;70;70;70;71;70;71;70 09:08:12 INFO - 2015-11-27 09:08:12,658 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;95;84;83;84;82;82;89;84;84;92 09:08:12 INFO - 2015-11-27 09:08:12,658 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;130;131;124;122;128;127;124;119;130 09:08:12 INFO - 2015-11-27 09:08:12,658 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;134;144;147;146;147;148;153;146;144 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;68;68;68;67;71;68;67 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,992 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: __startTimestamp1448644092651__endTimestamp 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.87 (3.5%) stddev-sans-first:4.04 09:08:12 INFO - 2015-11-27 09:08:12,659 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 106.0 112.0 113.0 112.0 103.0 112.0 112.0 105.0 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.40 Median:150.50 stddev:14.83 (9.9%) stddev-sans-first:15.12 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: Values: 160.0 138.0 150.0 173.0 133.0 151.0 150.0 131.0 166.0 132.0 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 162.0 161.0 160.0 160.0 159.0 161.0 161.0 161.0 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:73.00 stddev:11.57 (15.9%) stddev-sans-first:11.90 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 79.0 97.0 72.0 72.0 71.0 100.0 92.0 73.0 09:08:12 INFO - 2015-11-27 09:08:12,660 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:94.00 stddev:16.83 (17.9%) stddev-sans-first:17.39 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 131.0 94.0 95.0 94.0 132.0 94.0 95.0 124.0 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 150.0 146.0 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,661 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 09:08:12 INFO - 2015-11-27 09:08:12,662 DEBUG : BROWSER_OUTPUT: Values: 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 09:08:12 INFO - 2015-11-27 09:08:12,662 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,662 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.70 Median:72.50 stddev:2.71 (3.7%) stddev-sans-first:2.86 09:08:12 INFO - 2015-11-27 09:08:12,662 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 73.0 71.0 72.0 72.0 71.0 79.0 69.0 75.0 09:08:12 INFO - 2015-11-27 09:08:12,662 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,663 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 09:08:12 INFO - 2015-11-27 09:08:12,663 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 70.0 70.0 70.0 70.0 71.0 70.0 71.0 70.0 09:08:12 INFO - 2015-11-27 09:08:12,663 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,663 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.00 stddev:4.51 (5.4%) stddev-sans-first:3.37 09:08:12 INFO - 2015-11-27 09:08:12,663 DEBUG : BROWSER_OUTPUT: Values: 95.0 84.0 83.0 84.0 82.0 82.0 89.0 84.0 84.0 92.0 09:08:12 INFO - 2015-11-27 09:08:12,663 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,663 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:127.50 stddev:4.64 (3.6%) stddev-sans-first:4.11 09:08:12 INFO - 2015-11-27 09:08:12,664 DEBUG : BROWSER_OUTPUT: Values: 118.0 130.0 131.0 124.0 122.0 128.0 127.0 124.0 119.0 130.0 09:08:12 INFO - 2015-11-27 09:08:12,664 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,664 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:146.50 stddev:4.77 (3.3%) stddev-sans-first:5.05 09:08:12 INFO - 2015-11-27 09:08:12,664 DEBUG : BROWSER_OUTPUT: Values: 145.0 134.0 144.0 147.0 146.0 147.0 148.0 153.0 146.0 144.0 09:08:12 INFO - 2015-11-27 09:08:12,664 DEBUG : BROWSER_OUTPUT: 09:08:12 INFO - 2015-11-27 09:08:12,664 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 09:08:12 INFO - 2015-11-27 09:08:12,664 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 68.0 68.0 67.0 71.0 68.0 67.0 09:08:12 INFO - 2015-11-27 09:08:12,664 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:08:12 INFO - 2015-11-27 09:08:12,665 DEBUG : BROWSER_OUTPUT: 09:08:13 INFO - 2015-11-27 09:08:13,603 INFO : Browser exited with error code: 0 09:08:13 INFO - 2015-11-27 09:08:13,658 INFO : Completed test kraken (00:01:00) 09:08:13 INFO - 2015-11-27 09:08:13,658 INFO : Starting test v8_7 09:08:13 INFO - 2015-11-27 09:08:13,659 DEBUG : operating with platform_type : linux_ 09:08:13 INFO - 2015-11-27 09:08:13,659 INFO : Initialising browser for v8_7 test... 09:08:13 INFO - 2015-11-27 09:08:13,665 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Yq_dt/profile http://localhost:59088/getInfo.html 09:08:17 INFO - 2015-11-27 09:08:17,846 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:08:17 INFO - 2015-11-27 09:08:17,847 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:08:17 INFO - 2015-11-27 09:08:17,847 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:08:17 INFO - 2015-11-27 09:08:17,847 DEBUG : BROWSER_OUTPUT: __metrics 09:08:18 INFO - 2015-11-27 09:08:18,044 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:08:19 INFO - 2015-11-27 09:08:19,335 INFO : Browser initialized. 09:08:19 INFO - 2015-11-27 09:08:19,335 INFO : Running cycle 1/1 for v8_7 test... 09:08:19 INFO - 2015-11-27 09:08:19,336 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8Yq_dt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:08:31 INFO - 2015-11-27 09:08:31,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 138743808 09:08:31 INFO - 2015-11-27 09:08:31,190 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,625 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59088/tests/v8_7/run.html (next: http://localhost:59088/tests/v8_7/run.html) 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 446496768 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: |0;Richards;164.98927569707968 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.75455417066155 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 09:08:52 INFO - 2015-11-27 09:08:52,875 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 09:08:52 INFO - 2015-11-27 09:08:52,876 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 09:08:52 INFO - 2015-11-27 09:08:52,876 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 09:08:52 INFO - 2015-11-27 09:08:52,876 DEBUG : BROWSER_OUTPUT: |6;Boyer;12407.407407407407 09:08:52 INFO - 2015-11-27 09:08:52,876 DEBUG : BROWSER_OUTPUT: |7;RegExp;26051.28205128205 09:08:52 INFO - 2015-11-27 09:08:52,876 DEBUG : BROWSER_OUTPUT: |8;Splay;619.9628022318661 09:08:52 INFO - 2015-11-27 09:08:52,876 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 09:08:52 INFO - 2015-11-27 09:08:52,876 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:08:52 INFO - 2015-11-27 09:08:52,876 DEBUG : BROWSER_OUTPUT: __startTimestamp1448644132874__endTimestamp 09:08:52 INFO - 2015-11-27 09:08:52,876 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.99 Median:164.99 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: Values: 165.0 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.75 Median:191.75 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: Values: 191.8 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,877 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: Values: 278.2 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: Values: 5196.9 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: Values: 1992.0 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: Values: 796.2 09:08:52 INFO - 2015-11-27 09:08:52,878 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,879 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,880 DEBUG : BROWSER_OUTPUT: Values: 12407.4 09:08:52 INFO - 2015-11-27 09:08:52,880 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,880 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26051.28 Median:26051.28 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,880 DEBUG : BROWSER_OUTPUT: Values: 26051.3 09:08:52 INFO - 2015-11-27 09:08:52,880 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,880 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.96 Median:619.96 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,881 DEBUG : BROWSER_OUTPUT: Values: 620.0 09:08:52 INFO - 2015-11-27 09:08:52,881 DEBUG : BROWSER_OUTPUT: 09:08:52 INFO - 2015-11-27 09:08:52,881 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:08:52 INFO - 2015-11-27 09:08:52,881 DEBUG : BROWSER_OUTPUT: Values: 4826.9 09:08:52 INFO - 2015-11-27 09:08:52,881 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:08:52 INFO - 2015-11-27 09:08:52,881 DEBUG : BROWSER_OUTPUT: 09:08:53 INFO - 2015-11-27 09:08:53,743 INFO : Browser exited with error code: 0 09:08:53 INFO - 2015-11-27 09:08:53,760 INFO : Completed test v8_7 (00:00:40) 09:08:53 INFO - 2015-11-27 09:08:53,862 INFO : Completed test suite (00:20:18) 09:08:53 INFO - 2015-11-27 09:08:53,862 DEBUG : Working with test: dromaeo_css 09:08:53 INFO - 2015-11-27 09:08:53,862 DEBUG : Generating results file: dromaeo_css 09:08:53 INFO - 2015-11-27 09:08:53,863 DEBUG : Working with test: kraken 09:08:53 INFO - 2015-11-27 09:08:53,863 DEBUG : Generating results file: kraken 09:08:53 INFO - 2015-11-27 09:08:53,864 INFO : javascript benchmark 09:08:53 INFO - 2015-11-27 09:08:53,864 DEBUG : Working with test: v8_7 09:08:53 INFO - 2015-11-27 09:08:53,864 DEBUG : Generating results file: v8_7 09:08:53 INFO - 2015-11-27 09:08:53,864 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:08:53 INFO - 2015-11-27 09:08:53,940 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:08:53 INFO - 2015-11-27 09:08:53,940 DEBUG : process_Request line: dromaeo_css 6191.48 graph.html#tests=[[72,132,35]] 09:08:53 INFO - 2015-11-27 09:08:53,940 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:08:53 INFO - 2015-11-27 09:08:53,971 DEBUG : process_Request line: kraken 1523.00 graph.html#tests=[[232,132,35]] 09:08:53 INFO - 2015-11-27 09:08:53,972 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:08:54 INFO - 2015-11-27 09:08:54,004 DEBUG : process_Request line: v8_7 19715.20 graph.html#tests=[[230,132,35]] 09:08:54 INFO - 2015-11-27 09:08:54,005 INFO : javascript benchmark 09:08:54 INFO - 2015-11-27 09:08:54,009 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2606.973930260697, 2682.5439675255216, 2699.0148595762553, 2713.2809805401566, 2720.319920019995, 4526.773661316937, 4612.031473390588, 4615.884602884926, 4621.029583787405, 4669.603083737878, 4531.43357080365, 4553.453585569728, 4620.792064357103, 4648.558386953234, 4655.185342565054, 4337.154254920292, 4358.063016451462, 4368.606825385715, 4373.497047839507, 4400.405945197389, 4154.5222299435645, 4390.319500477431, 4394.582514661118, 4429.092036132602, 4449.154660614473, 4200.789960501963, 4263.616274535307, 4273.081287523198, 4286.549912259199, 4302.720323178984, 4295.828166873322, 4308.332208507686, 4325.480942286914, 4355.716878402925, 4367.475902891641, 4128.298189307825, 4279.486461624625, 4285.507166675841, 4301.397804307399, 4334.068175342285, 4526.773661316954, 4534.77326133692, 4553.089382123589, 4553.977230113861, 4566.657500687428, 4924.916518365953, 4954.826581069645, 4957.206846904514, 4961.330220420233, 4970.90058198834, 4968.428630707479, 4980.77586508608, 4988.176950803113, 4993.176125939216, 4994.725290109042, 4547.8635640930825, 4616.053708989649, 4616.469106052847, 4653.208954477713, 4674.602658774008, 5108.386993560722, 5121.2574176744165, 5133.23001549763, 5179.948200517946, 5187.922181167285, 4745.074710431501, 4856.417229932431, 4863.076015557103, 4924.482929292444, 4927.482614325516, 4854.757262136879, 4968.503149685002, 4980.825671101494, 4981.0, 4989.925151122736, 4940.110780059624, 4968.850934471971, 4972.90054198914, 4977.97951419958, 5007.574356179693, 4946.332245146859, 4946.703197808143, 4954.950450495521, 4956.628252881048, 4992.226204938168, 4080.571539988318, 4173.6661067114555, 4178.26880295947, 4192.0, 4311.849085282063, 3637.3270944875285, 3687.3362794697214, 3690.2619476104887, 3724.0131365188245, 3734.8319325630414, 4288.120935208275, 4293.763842988603, 4297.505786834554, 4299.54854740254, 4341.522432532419, 4822.445418776815, 4857.514248575114, 4929.038837426668, 4937.061958227925, 4962.230854217602, 4284.700070995001, 4294.420253265769, 4309.095090031066, 4313.051128751732, 4333.653307735373, 4466.843660471868, 4487.439070116236, 4488.4165058542185, 4513.864584062483, 4540.091981603692, 4585.839495617637, 4601.4938356781395, 4679.4852566217005, 4685.437747470257, 4728.692634978715, 4982.900341993212, 5002.299678045149, 5016.799328026838, 5021.49785021495, 5057.8229761958155, 4712.151812673752, 4740.3837501124635, 4746.857594272177, 4751.524847515221, 4789.688670236424, 4682.0869930364615, 4762.928556071731, 4787.0904528139545, 4813.3983252093485, 4940.75296235194, 5008.248762685481, 5051.949480505295, 5052.191649336089, 5073.644844860824, 5105.412877519133, 4899.289603007615, 4902.950970490249, 4905.043516514388, 4910.06708725341, 4946.060248552763, 4657.347971284091, 4724.97637511824, 4760.904781904412, 4761.785719642694, 4893.804247830047, 4738.905221895474, 4755.405574303212, 4755.928661070156, 4758.167320718791, 4767.856964291077, 4861.65968382224, 4867.58625516835, 4869.732164730974, 4870.805167793249, 4904.730239836843, 4578.359029735906, 4667.486576476517, 4692.507286734844, 4693.296005599187, 4780.211265141213], "unit": "ms", "name": "dojo.html", "value": 4567.113391501155}, {"lowerIsBetter": false, "replicates": [550.4495504495504, 573.498189084551, 574.4083593898283, 577.7284676202183, 580.0, 27799.722002779967, 28428.57357139642, 37548.808351290136, 37993.240135197346, 38077.8096109519, 40737.18525629493, 41250.58749412505, 41285.0, 41288.79355603225, 41322.173556528855, 7072.080629518156, 7660.502067365631, 7772.844543109134, 7795.922040779605, 7803.258690424429, 7032.296770322952, 7127.786166415016, 7135.143782746078, 7159.319864612853, 10102.14131798798, 9984.750381240454, 10076.445795481246, 10078.193744500422, 10084.49577521121, 10095.242856785733, 9802.754931126743, 9912.05835445635, 9916.0, 9919.40483570988, 9953.502324883726, 9839.90160098397, 10016.949915250378, 10016.94991525045, 10017.649382271586, 10018.499075046218, 36460.27079458396, 36703.449448258296, 36896.63103368985, 36914.0, 37018.44472332917, 2751.435955629091, 2754.628125203092, 2757.9724202757916, 2828.844413557274, 3296.291297371077, 27692.0, 28146.718532814615, 28188.436231275464, 28375.432491350057, 28558.143255702154, 3435.7423193260356, 3455.58532976042, 3476.513288139637, 3516.261585067139, 3594.19130695594, 222473.0, 223075.99999999837, 223141.0, 223283.0, 223587.0, 48572.0, 51510.48489515132, 52234.0, 52236.47763522392, 52271.73864130655, 45964.0, 59777.0, 61381.38618613846, 61396.693016534635, 61430.69284653548, 12715.682107947376, 12940.870591294155, 12951.093423460456, 12952.0, 12952.158109722837, 8126.39052071097, 8257.504549727035, 9099.727008189633, 9154.267658587298, 9595.664151754794, 17689.11554422274, 17865.821341786675, 17930.91034544819, 17973.1013449327, 17973.550661233574, 7373.705051797975, 7510.586917719578, 7550.697972081165, 7575.24247575238, 7647.426443016796, 836.9874451883227, 879.4415546128255, 939.300221335096, 953.952302384878, 1025.497506221946, 25775.87112064428, 25802.870985644953, 26253.73746262513, 26784.33039174036, 27342.863285683445, 903.5301643145659, 938.7512309238058, 942.8962814090445, 1009.4094954451581, 1035.0425856083093, 12443.93778031104, 12635.1787133836, 12704.745905081847, 12791.552295669608, 12798.488060477477, 212972.0, 215066.0, 215570.0, 216604.0, 216873.0, 43602.7819860905, 43656.56343436588, 43668.781656091516, 43722.781386092865, 43815.56184438179, 1190.8511436070492, 1193.242291145129, 1210.0863847794858, 1221.7190046289404, 1224.5591587028662, 24029.27912162638, 24626.0, 24726.258212253662, 24847.25458236256, 25190.49619007573, 38988.80505597454, 39294.214115718096, 39302.41046384364, 39350.2129957405, 39371.409428858016, 255479.0, 256499.0, 258295.0, 258347.0, 258401.0, 24076.87961560181, 24602.876985614956, 27555.586666200423, 28118.859405702842, 28252.293692657026, 32652.510212347308, 32857.50713739248, 33820.0, 33848.830755846066, 35675.28649426945, 31228.53157202689, 31350.05949821509, 31876.36247275088, 32919.17702057468, 33494.49758253579, 26472.42622246049, 31815.522767158047, 34864.0, 35599.82200088983, 35879.641203588675, 32566.674333257313, 32602.34795304128, 32918.177045574055, 33004.83497582593, 33124.33751325008, 27161.59257611098, 28636.14091577256, 28639.42721145607, 28721.569176462788, 28735.137945861657, 22600.434989125402, 23405.41486462852, 30285.0, 31659.683403165673, 32451.513227301137], "unit": "ms", "name": "ext.html", "value": 16706.19978096906}, {"lowerIsBetter": false, "replicates": [310.74984637366924, 314.93543823516154, 323.8202797447417, 324.61046743907315, 325.9967400325997, 14740.852591474082, 15162.090274583532, 15210.315535800888, 15655.608609784762, 15743.134127622976, 14191.432342706305, 14192.645183870409, 14366.856331436682, 14436.350364233609, 14826.82373005721, 4803.8799030024265, 4915.139850526161, 4923.236898280772, 4924.532169443915, 4930.926036109461, 4922.4585295617635, 4934.555889969902, 4941.579965702902, 4950.0, 4955.851324460272, 3459.5848498180126, 3592.0, 4804.639652026094, 4975.353204083464, 5398.541124004464, 5468.781248750045, 5496.725163741797, 5521.2270282160525, 5527.44725527446, 5529.0324193266215, 2361.0, 2364.8344615876895, 3795.6773674237725, 4770.594499467549, 4784.330193772875, 14448.927755361156, 14948.775768363483, 17666.205020774098, 18415.907920460446, 19353.322633707754, 1800.5948661551176, 1873.7002079667188, 1891.943241702751, 1946.746922900014, 2012.0845015517905, 12436.875631243753, 12449.190802597803, 12585.0, 12706.364681765966, 12776.61670149897, 1696.720041193214, 1708.9914550427168, 1747.4670225581192, 1776.9378071767555, 1833.0926191535143, 55091.0, 55414.44585554174, 56136.87726245493, 56314.43685563133, 56329.43670563283, 9034.45793252407, 9139.0, 9169.35814492979, 9258.95370523143, 9270.814583708288, 11852.940735296268, 11876.228045177037, 11876.940615296868, 11882.049436045096, 11883.762324753456, 6653.767118150939, 6664.166979127609, 6687.030380594787, 6740.730370785113, 6772.492063095287, 6323.43089121972, 6360.618362898241, 6383.840403989938, 6391.392817682313, 6411.551191416556, 5594.608377413542, 5652.208690783294, 5655.830325090254, 5665.631733937281, 5685.6304340218585, 1560.4928398270608, 1577.242923396776, 1608.5817687401127, 1611.395726602524, 1616.9838301616833, 667.462692532516, 808.9029316481942, 820.5445977482555, 834.7245409015011, 837.6523742646733, 15686.843131568538, 15810.683786324209, 15906.204689765696, 15946.122963237134, 16299.511014669579, 826.4586695714316, 840.7813968368268, 871.0897112517434, 878.1262643669462, 893.821235752852, 7675.616219189018, 8975.37172397939, 9207.723768286962, 9263.629454821732, 9332.673356432493, 529542.0, 530046.0, 530360.0, 548238.0, 558934.0, 69457.0, 71425.64287178635, 72303.2769672307, 72540.63729681318, 73397.26602734011, 1067.5089458849016, 1082.9187810914214, 1090.0353187429182, 1092.5465931638282, 1093.3767752381225, 14630.122192668474, 14696.338664760326, 14707.92646036763, 14808.407663693763, 15210.391584336503, 33734.0, 33870.0, 33920.321593568486, 34185.82907085449, 34223.828880855435, 44692.0, 44695.32957005582, 44724.77637611791, 45638.31542526931, 48247.0, 8157.75526734199, 8158.551279679675, 8283.668653253802, 8301.667933282843, 8831.293496520391, 15738.291776870297, 15800.288986995844, 15932.601684957968, 16055.0, 16479.752803707714, 9333.553299238629, 12908.41912113976, 13325.200487970753, 13602.183868967893, 14097.436102556194, 12505.624831255076, 12530.874691252971, 12549.435275412447, 12677.112602118132, 12965.740685186433, 13010.544630937871, 13068.281244531261, 13078.673033174247, 13313.933430332787, 13338.26639534835, 8011.3590912728005, 8162.7143049992965, 8608.09614990417, 8684.913150868411, 8704.738857834274, 12701.36493175319, 13023.088383813041, 13077.803832942323, 13418.93290533541, 13465.730685386434], "unit": "ms", "name": "jquery.html", "value": 8185.835104866763}, {"lowerIsBetter": false, "replicates": [1332.5269529317086, 1373.7321222361638, 1399.3073428652817, 1510.09394363382, 1587.6824635072987, 5718.685472299022, 6344.302126766058, 6524.836879078025, 6528.31452697467, 6534.281229064805, 6547.34526547345, 6666.333366663332, 6670.366315200048, 6683.899741503881, 6684.866302673956, 1676.9916150419292, 1695.0592421206225, 1697.2277613685744, 1971.2509246486316, 2004.7694515130727, 1940.922363105474, 1997.5805080933021, 1998.1407994562333, 1998.7601487821482, 1999.7000449932555, 1902.8097190281, 1929.7491326127583, 1931.0537836460173, 1947.9902600486978, 1949.512621844539, 1939.85451091168, 1960.127743154297, 1964.6463636545416, 1965.3317871923543, 1965.665836807739, 1940.194819150065, 1975.1111999600093, 1978.2186036515495, 1984.2459865251112, 1986.3047933223402, 6490.2536208335705, 6559.2128944526485, 6559.770408035696, 6562.770303039419, 6563.967180164116, 3556.3598552260582, 3614.313280476701, 3640.3993341098685, 3647.0335361129323, 3647.215848592565, 2520.0, 2569.40903592173, 2580.4839032193636, 2631.1317265302405, 2644.867756612162, 746.8580969615809, 761.6077719974218, 804.1676864445329, 886.1138861138861, 941.2140862379921, 8638.308935285162, 8678.566071696454, 8686.435381700168, 8692.739217823411, 8694.478331300143, 3511.2099777549847, 3516.9648303517147, 3522.0314413536485, 3544.379733546619, 3553.680168784822, 7631.923680763232, 7682.078150621961, 7682.347000504908, 7682.692692292358, 7686.9231307686205, 3878.0111071676542, 3879.6120387960977, 3879.631435013669, 3879.689624830007, 3887.2225554889137, 3504.176518518197, 3505.772124811879, 3525.1715846775987, 3530.629283925151, 3531.8168413581225, 2801.2016575275948, 2839.389531250791, 3125.5311703244697, 3138.325260069096, 3154.794938329001, 881.1232823340816, 901.4140808474544, 902.8104098139333, 925.6251218256482, 985.093713783321, 912.7124955638952, 921.3274309753783, 963.325672029582, 971.3928794503436, 1157.3923690062784, 6304.558680892385, 6330.651814150266, 6359.0, 6370.331115232926, 6371.33101024395, 1007.09361574582, 1071.4856868703066, 1097.237419993097, 1102.9062529685066, 1127.8533790607169, 5049.722265275372, 5079.720615366116, 5104.821331253388, 5105.106606343875, 5168.043911876315, 7801.726939557088, 7895.6052197391045, 7911.802204944807, 7943.364530837519, 7957.840843183104, 7655.387568994467, 7848.0, 7855.293023627786, 7858.096318923397, 7892.092409372881, 6288.937110628926, 6306.1171435998995, 6308.684565771785, 6344.302126766052, 6353.841153971095, 6070.332263451105, 6146.569740118149, 6151.200343955257, 6152.78465253714, 6161.44546990773, 7113.786586402416, 7172.354488096096, 7182.96408517954, 7218.89171662415, 7238.23998480152, 7172.677229524788, 7231.819204519929, 7333.046703928455, 7340.669669864976, 7355.117385913724, 5387.191921211693, 5395.892082158413, 5433.130699088127, 5453.754581043783, 5462.8907421850545, 6189.04069869171, 6226.40849119333, 6238.095476155841, 6244.1570387997035, 6254.749050189889, 5275.076861549291, 6035.36628653985, 6151.50787936955, 6221.688915554295, 6305.1172835803945, 5303.496167864047, 5912.290525137011, 5938.287405511366, 5964.582479226413, 6034.306054803754, 6091.543134264859, 6176.197094377702, 6202.2867370253, 6211.9068213975925, 6216.2540495139065, 5660.85847853807, 5664.745086471036, 5674.57440691958, 5680.318361796611, 5683.488486036276, 5880.088586269135, 5900.498457631149, 5900.911486327623, 5914.67469289176, 5915.70421478933], "unit": "ms", "name": "mootools.html", "value": 3805.0170027263644}, {"lowerIsBetter": false, "replicates": [289.9811512251703, 290.8167854251821, 293.96913324100956, 294.5390463923959, 295.3030847200606, 5230.823064810415, 5255.237990491381, 5318.867028324294, 5345.305110335651, 5377.435369286218, 5241.764120614572, 5299.814506492274, 5314.521693047625, 5315.0698627740185, 5317.5480084192795, 4094.8362065517344, 4114.218298523286, 4114.7119701620895, 4116.300228961069, 4117.526484454281, 3831.63599458051, 3932.5674175840636, 3992.061865461614, 4099.856505022325, 4102.774347410891, 4044.1911617676437, 4049.8785036448953, 4050.5544390117066, 4058.330375488056, 4078.5717499662555, 3819.5034645495907, 3948.190620922704, 4063.14673918476, 4067.8169482373364, 4068.023674318157, 3386.7629265951145, 3450.6376830432696, 3459.4637831136215, 3459.705924996378, 3460.0311912664492, 5005.049040682259, 5009.849704508871, 5011.198208286657, 5016.122178618727, 5019.19692849146, 4538.52345503724, 4542.386777785023, 4547.067851090518, 4549.363089167519, 4549.567791059844, 5381.165919282517, 5442.102053161224, 5455.345358556959, 5456.045192091407, 5458.344998600153, 3853.0560012796764, 3853.7687738735485, 3854.6338097880657, 3858.054776579728, 3858.575556688762, 5791.073428251501, 5850.385709500526, 5853.970730146365, 5869.413058694139, 5869.413058694139, 3893.201893611803, 3894.7078969077434, 3898.8830335089992, 3899.200663863901, 3901.297766402075, 3952.347862602696, 3953.525576930729, 3955.9011024724036, 3959.5050618672667, 3961.861334853324, 4506.594406503365, 4594.471635761864, 4634.0036892068365, 4636.095961287584, 4641.396618439581, 5569.944300557024, 5570.108782594765, 5571.498565129077, 5575.888482230333, 5587.05020146576, 1391.679913619873, 1426.522115091456, 1426.657602175491, 1426.7360538300447, 1426.8002479652857, 950.7432993091827, 952.2096659772373, 955.1880901233895, 965.7778710896533, 976.0776066616979, 4901.950980490149, 4914.8034078637165, 4915.606751459874, 4919.581835543947, 4924.901501969941, 5790.305163380422, 5804.448577385142, 5808.535317174616, 5808.676529388278, 5812.912806307909, 4906.828261010847, 4908.754562271872, 4909.214525675875, 4911.45973942866, 4917.065757506062, 2995.655499617572, 3024.2590565311198, 3095.721385075354, 3126.5935428394164, 3129.796563223383, 5412.621116521806, 5443.537299329601, 5534.557235421156, 5542.307211598551, 5547.916781248285, 5960.0, 5968.1644569760265, 5995.850103747354, 6010.278766548042, 6014.977453832859, 5493.890122197614, 5521.889562208814, 5529.889402212014, 5534.916976245359, 5542.39033706292, 5690.77236910519, 5837.949169149594, 5868.413158684098, 5869.383714709894, 5875.6474611523445, 5711.914321285101, 5712.714364281686, 5715.31416230055, 5718.714064296852, 5719.3136823581435, 5529.778808847601, 5536.390996990247, 5542.334919809648, 5543.390227074938, 5545.029619816597, 3829.9234015320094, 3945.467361906106, 3980.184062267286, 3981.462502562117, 3983.24318379507, 5789.942100579109, 5818.33089194748, 5818.76724931015, 5820.73806678692, 5822.301323841166, 5591.077472217039, 5598.244237027949, 5605.523530499953, 5608.242887210175, 5616.85957851057, 5602.803901863415, 5607.327120745536, 5615.466530679579, 5616.241807355955, 5617.466340697627, 5370.462953704755, 5493.203485494501, 5495.560355171657, 5500.312460942382, 5503.972480137573, 5626.2967129108865, 5631.239782629293, 5639.379668236573, 5640.85897852557, 5647.435256474319, 5508.173773933942, 5514.36584792754, 5514.5864060194845, 5517.310336207974, 5519.39286678457], "unit": "ms", "name": "prototype.html", "value": 4164.824566679782}, {"lowerIsBetter": false, "replicates": [689.3554526517706, 766.088354857719, 770.214381331042, 773.7833406646138, 794.213728408875, 10534.789304213911, 10776.353418794877, 10785.784284314328, 10798.2441229114, 10807.729806754825, 10099.343542669722, 10625.46872656366, 10759.569617215302, 10762.0, 11523.19337646365, 757.5076200469683, 772.5480593852603, 773.2036002916976, 773.798812308801, 774.0943096577018, 767.4282659418741, 773.8065483629093, 774.0131332551015, 774.0788461730523, 774.4346626962292, 814.0150417994234, 819.1603606303556, 821.1870248454018, 821.2116368286452, 821.5399376349263, 811.6144831205189, 813.9715109971153, 815.9347252219808, 816.3346872299057, 816.3673153306175, 601.3986013986014, 601.7081715368043, 602.1990752299475, 602.9005214139662, 602.9095635654687, 10631.893681063168, 10772.192085593611, 10790.67627971162, 10799.352038877692, 10801.5679372825, 11426.37154956477, 11612.0, 11939.22395044328, 12065.879341206562, 12164.02687784975, 9082.77293067672, 9326.813463730756, 9327.860082098774, 10038.0, 10163.441010744406, 3207.9679203208134, 3221.742260619168, 3243.2702641905385, 3278.50822376643, 3356.8992930212135, 34245.486317705254, 34562.308753824786, 41659.7917010413, 41896.58103418957, 42622.78688606537, 7493.925060749323, 9162.587683554257, 9219.953900230455, 9440.29197810167, 9466.148046675695, 14149.08030977983, 14311.35598898052, 14317.0, 14321.212333321768, 16630.83369166317, 6398.744050237939, 6512.706928188243, 6546.476281897437, 6674.966625166843, 6715.664216789239, 3644.4715516249994, 3664.5419322584676, 3725.4784330193793, 3727.8881633551036, 3759.2293579816073, 2674.5453272943646, 2704.080612591689, 2705.4318593095277, 2705.4318593095277, 2706.526357887362, 479.23561918739557, 482.5584590100019, 483.789551545079, 495.01739047989713, 499.910016197088, 529.2035486592654, 587.4800801290803, 609.3540846702509, 617.2130533569645, 635.4344633276388, 7129.714811407589, 7598.800763150788, 7625.0, 7627.275408836263, 7643.121041080347, 537.9112446446371, 565.8019693107461, 580.077676494376, 599.3598199929319, 606.2300877885061, 3419.9487007694906, 3569.1077230692326, 3580.534530511017, 3589.748717589796, 3632.146445585285, 50043.74978125086, 50911.74544127256, 51040.0, 51275.23087153696, 51400.74299628478, 45516.772416137705, 45611.54388456073, 45854.54145458503, 46164.07671846544, 46209.0, 35441.46837797435, 38604.80697596494, 43015.0, 45961.540384595726, 46122.07755844932, 7935.404844636791, 7953.403494737802, 8038.437309388287, 8145.592720364077, 8172.5913704315735, 31643.0, 32255.0, 32479.02562923116, 32634.51048234231, 33046.0, 38550.807245964716, 38875.416868746426, 39224.2155156901, 40159.0, 40729.1854162921, 8861.556922153995, 9581.281403894875, 9932.900670993487, 9985.201183905416, 10085.949570252102, 11091.667249982513, 11160.609378671708, 11536.82694759596, 12243.20419172751, 12259.141860069709, 9426.24590032782, 9876.555554999899, 10362.481875906326, 10394.948025259826, 10739.838902416313, 11036.724081897695, 11203.551857925917, 11267.549298027987, 11559.653210403701, 11584.652460426201, 10409.895901040893, 10649.201309901633, 10711.00359152932, 11092.168087393316, 11101.056410205223, 8811.427257228259, 8908.710275922844, 9023.759817079024, 9190.724278271662, 9289.256859451092, 8810.647574096964, 9429.952850235704, 9481.241500680067, 9494.145526902612, 9542.33203675736], "unit": "ms", "name": "yui.html", "value": 5690.931005608419}], "name": "dromaeo_css", "value": 6191.480563093621}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 106.0, 112.0, 113.0, 112.0, 103.0, 112.0, 112.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [160.0, 138.0, 150.0, 173.0, 133.0, 151.0, 150.0, 131.0, 166.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.4}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 161.0, 160.0, 160.0, 159.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 79.0, 97.0, 72.0, 72.0, 71.0, 100.0, 92.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 131.0, 94.0, 95.0, 94.0, 132.0, 94.0, 95.0, 124.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 150.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 71.0, 72.0, 72.0, 71.0, 79.0, 69.0, 75.0], "unit": "ms", "name": "json-parse-financial", "value": 72.7}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [95.0, 84.0, 83.0, 84.0, 82.0, 82.0, 89.0, 84.0, 84.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [118.0, 130.0, 131.0, 124.0, 122.0, 128.0, 127.0, 124.0, 119.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [145.0, 134.0, 144.0, 147.0, 146.0, 147.0, 148.0, 153.0, 146.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 67.0, 71.0, 68.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1523.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.98927569707968], "unit": "score", "name": "Richards", "value": 213.96542200000005}, {"lowerIsBetter": false, "replicates": [191.75455417066155], "unit": "score", "name": "DeltaBlue", "value": 344.80537}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [26051.28205128205], "unit": "score", "name": "RegExp", "value": 34.96891240157479}, {"lowerIsBetter": false, "replicates": [619.9628022318661], "unit": "score", "name": "Splay", "value": 131.44498299999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19715.196985995644}]} 09:08:54 INFO - RETURN: dromaeo_css: 6191.48 09:08:54 INFO - RETURN: kraken: 1523.00 09:08:54 INFO - RETURN: v8_7: 19715.20 09:08:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19715.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6191.48"}}} 09:08:54 INFO - Return code: 0 09:08:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:08:54 INFO - # TBPL SUCCESS # 09:08:54 INFO - Running post-action listener: _resource_record_post_action 09:08:54 INFO - Running post-run listener: _resource_record_post_run 09:08:55 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 503017472; Read time: 4; Write time: 536800 09:08:55 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 229560320; Read time: 0; Write time: 379396 09:08:55 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273457152; Read time: 4; Write time: 157404 09:08:55 INFO - Running post-run listener: _upload_blobber_files 09:08:55 INFO - Blob upload gear active. 09:08:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:08:55 INFO - Copying logs to upload dir... 09:08:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.186807 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-11-27 09:08:54.935742) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 09:08:54.939406) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009941 build_url: 'https://queue.taskcluster.net/v1/task/ggIMCb0-RFmPMJEWruhbcQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 09:08:54.992341) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 09:08:54.992644) ========= 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=1d09c2d9237d126f9c84bbb400000198-1448641182.262310-547936228 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 09:08:55.042562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 09:08:55.042831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 09:08:55.043158) ========= ========= Total master_lag: 0.23 =========