builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1450342353.26 results: success (0) buildid: 20151216235732 builduid: e3092e3f7a3645b2b1ddfc91a207b9a5 revision: bb0e4752f9bbab121139b52ed6dbff7b5b1f08e2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.260984) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.261486) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.261814) ========= 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=5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006376 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.292903) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.293217) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.306699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.307050) ========= 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=5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004606 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.357332) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.357681) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.358081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.358487) ========= 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=5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 00:52:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2015-12-17 00:52:34 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.170675 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.542179) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.542645) ========= 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=5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020871 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:33.594551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 00:52:33.594960) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev bb0e4752f9bbab121139b52ed6dbff7b5b1f08e2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev bb0e4752f9bbab121139b52ed6dbff7b5b1f08e2 --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=5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 00:52:34,280 truncating revision to first 12 chars 2015-12-17 00:52:34,280 Setting DEBUG logging. 2015-12-17 00:52:34,280 attempt 1/10 2015-12-17 00:52:34,280 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/bb0e4752f9bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 00:52:35,296 unpacking tar archive at: b2g-inbound-bb0e4752f9bb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322843 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 00:52:34.931947) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:34.932578) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:34.944237) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:34.944863) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 00:52:34.945600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-17 00:52:34.946137) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:52:35 INFO - MultiFileLogger online at 20151217 00:52:35 in /builds/slave/test 00:52:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 00:52:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:52:35 INFO - {'append_to_log': False, 00:52:35 INFO - 'base_work_dir': '/builds/slave/test', 00:52:35 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 00:52:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:52:35 INFO - 'branch': 'B2G-Inbound-Non-PGO', 00:52:35 INFO - 'buildbot_json_path': 'buildprops.json', 00:52:35 INFO - 'config_files': ('talos/linux_config.py',), 00:52:35 INFO - 'default_actions': ('clobber', 00:52:35 INFO - 'read-buildbot-config', 00:52:35 INFO - 'download-and-extract', 00:52:35 INFO - 'populate-webroot', 00:52:35 INFO - 'create-virtualenv', 00:52:35 INFO - 'install', 00:52:35 INFO - 'run-tests'), 00:52:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:52:35 INFO - 'download_minidump_stackwalk': True, 00:52:35 INFO - 'download_symbols': 'ondemand', 00:52:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:52:35 INFO - 'tooltool.py': '/tools/tooltool.py', 00:52:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:52:35 INFO - '/tools/misc-python/virtualenv.py')}, 00:52:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:52:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:52:35 INFO - 'installer_path': 'installer.exe', 00:52:35 INFO - 'log_level': 'info', 00:52:35 INFO - 'log_name': 'talos', 00:52:35 INFO - 'log_to_console': True, 00:52:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:52:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:52:35 INFO - 'opt_config_files': (), 00:52:35 INFO - 'pip_index': False, 00:52:35 INFO - 'sps_profile': False, 00:52:35 INFO - 'sps_profile_interval': 0, 00:52:35 INFO - 'suite': 'dromaeojs', 00:52:35 INFO - 'system_bits': '64', 00:52:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:52:35 INFO - 'title': 'talos-linux64-ix-059', 00:52:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:52:35 INFO - 'use_talos_json': True, 00:52:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:52:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:52:35 INFO - 'work_dir': 'build'} 00:52:35 INFO - ##### 00:52:35 INFO - ##### Running clobber step. 00:52:35 INFO - ##### 00:52:35 INFO - Running pre-action listener: _resource_record_pre_action 00:52:35 INFO - Running main action method: clobber 00:52:35 INFO - rmtree: /builds/slave/test/build 00:52:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:52:36 INFO - Running post-action listener: _resource_record_post_action 00:52:36 INFO - ##### 00:52:36 INFO - ##### Running read-buildbot-config step. 00:52:36 INFO - ##### 00:52:36 INFO - Running pre-action listener: _resource_record_pre_action 00:52:36 INFO - Running main action method: read_buildbot_config 00:52:36 INFO - Using buildbot properties: 00:52:36 INFO - { 00:52:36 INFO - "properties": { 00:52:36 INFO - "buildnumber": 307, 00:52:36 INFO - "product": "firefox", 00:52:36 INFO - "script_repo_revision": "production", 00:52:36 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 00:52:36 INFO - "repository": "", 00:52:36 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 00:52:36 INFO - "buildid": "20151216235732", 00:52:36 INFO - "slavename": "talos-linux64-ix-059", 00:52:36 INFO - "pgo_build": "False", 00:52:36 INFO - "basedir": "/builds/slave/test", 00:52:36 INFO - "project": "", 00:52:36 INFO - "platform": "ubuntu64_hw", 00:52:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:52:36 INFO - "slavebuilddir": "test", 00:52:36 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 00:52:36 INFO - "branch": "b2g-inbound", 00:52:36 INFO - "repo_path": "integration/b2g-inbound", 00:52:36 INFO - "stage_platform": "linux64", 00:52:36 INFO - "builduid": "e3092e3f7a3645b2b1ddfc91a207b9a5", 00:52:36 INFO - "revision": "bb0e4752f9bbab121139b52ed6dbff7b5b1f08e2" 00:52:36 INFO - }, 00:52:36 INFO - "sourcestamp": { 00:52:36 INFO - "repository": "", 00:52:36 INFO - "hasPatch": false, 00:52:36 INFO - "project": "", 00:52:36 INFO - "branch": "b2g-inbound-linux64-talos", 00:52:36 INFO - "changes": [ 00:52:36 INFO - { 00:52:36 INFO - "category": null, 00:52:36 INFO - "files": [ 00:52:36 INFO - { 00:52:36 INFO - "url": null, 00:52:36 INFO - "name": "https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 00:52:36 INFO - } 00:52:36 INFO - ], 00:52:36 INFO - "repository": "", 00:52:36 INFO - "rev": "bb0e4752f9bbab121139b52ed6dbff7b5b1f08e2", 00:52:36 INFO - "who": "echen@mozilla.com", 00:52:36 INFO - "when": 1450342298, 00:52:36 INFO - "number": 7370898, 00:52:36 INFO - "comments": "Bug 1232571 - Enable emu-x86-kk marionette-webapi tests on m-c and integration branches. r=garndt", 00:52:36 INFO - "project": "", 00:52:36 INFO - "at": "Thu 17 Dec 2015 00:51:38", 00:52:36 INFO - "branch": "b2g-inbound-linux64-talos", 00:52:36 INFO - "revlink": "", 00:52:36 INFO - "properties": [ 00:52:36 INFO - [ 00:52:36 INFO - "buildid", 00:52:36 INFO - "20151216235732", 00:52:36 INFO - "Change" 00:52:36 INFO - ], 00:52:36 INFO - [ 00:52:36 INFO - "builduid", 00:52:36 INFO - "e3092e3f7a3645b2b1ddfc91a207b9a5", 00:52:36 INFO - "Change" 00:52:36 INFO - ], 00:52:36 INFO - [ 00:52:36 INFO - "pgo_build", 00:52:36 INFO - "False", 00:52:36 INFO - "Change" 00:52:36 INFO - ] 00:52:36 INFO - ], 00:52:36 INFO - "revision": "bb0e4752f9bbab121139b52ed6dbff7b5b1f08e2" 00:52:36 INFO - } 00:52:36 INFO - ], 00:52:36 INFO - "revision": "bb0e4752f9bbab121139b52ed6dbff7b5b1f08e2" 00:52:36 INFO - } 00:52:36 INFO - } 00:52:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:52:36 INFO - Running post-action listener: _resource_record_post_action 00:52:36 INFO - ##### 00:52:36 INFO - ##### Running download-and-extract step. 00:52:36 INFO - ##### 00:52:36 INFO - Running pre-action listener: _resource_record_pre_action 00:52:36 INFO - Running main action method: download_and_extract 00:52:36 INFO - mkdir: /builds/slave/test/build/tests 00:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:36 INFO - https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/test_packages.json 00:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/test_packages.json 00:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:52:36 INFO - Downloaded 1302 bytes. 00:52:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:52:36 INFO - Using the following test package requirements: 00:52:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:52:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:36 INFO - u'jsshell-linux-x86_64.zip'], 00:52:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:52:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:52:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:52:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:52:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:52:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:52:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:52:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:36 INFO - https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:52:37 INFO - Downloaded 21869124 bytes. 00:52:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 00:52:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:52:39 INFO - Return code: 0 00:52:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:52: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')]} 00:52:39 INFO - https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:52:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:52:40 INFO - Downloaded 21869124 bytes. 00:52:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 00:52:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:52:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 00:52:41 INFO - Return code: 0 00:52: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')]} 00:52:41 INFO - https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:52:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:52:42 INFO - Downloaded 11132052 bytes. 00:52:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 00:52:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:52:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 00:52:43 INFO - Return code: 0 00:52:43 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')]} 00:52:43 INFO - https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:52:45 INFO - Downloaded 57741413 bytes. 00:52:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:52:45 INFO - mkdir: /builds/slave/test/properties 00:52:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:52:45 INFO - Writing to file /builds/slave/test/properties/build_url 00:52:45 INFO - Contents: 00:52:45 INFO - build_url:https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:52:45 INFO - Running post-action listener: _resource_record_post_action 00:52:45 INFO - Running post-action listener: set_extra_try_arguments 00:52:45 INFO - ##### 00:52:45 INFO - ##### Running populate-webroot step. 00:52:45 INFO - ##### 00:52:45 INFO - Running pre-action listener: _resource_record_pre_action 00:52:45 INFO - Running main action method: populate_webroot 00:52:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:52:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:52:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:52:45 INFO - '--tppagecycles', 00:52:45 INFO - '7'], 00:52:45 INFO - 'tests': ['tsvgm']}}, 00:52:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:52:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:52:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:52:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:52:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:52:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:45 INFO - 'talos_options': ['--e10s'], 00:52:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:52:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:45 INFO - 'tests': ['damp', 'tps']}, 00:52:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:45 INFO - 'talos_options': ['--e10s'], 00:52:45 INFO - 'tests': ['damp', 'tps']}, 00:52:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:52:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:52:45 INFO - 'other': {'tests': ['a11yr', 00:52:45 INFO - 'ts_paint', 00:52:45 INFO - 'tpaint', 00:52:45 INFO - 'sessionrestore', 00:52:45 INFO - 'sessionrestore_no_auto_restore']}, 00:52:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:52:45 INFO - 'tests': ['a11yr', 00:52:45 INFO - 'ts_paint', 00:52:45 INFO - 'tpaint', 00:52:45 INFO - 'sessionrestore', 00:52:45 INFO - 'sessionrestore_no_auto_restore']}, 00:52:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:52:45 INFO - 'tests': ['a11yr', 00:52:45 INFO - 'ts_paint', 00:52:45 INFO - 'tpaint', 00:52:45 INFO - 'sessionrestore', 00:52:45 INFO - 'sessionrestore_no_auto_restore']}, 00:52:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:52:45 INFO - 'tests': ['a11yr', 00:52:45 INFO - 'ts_paint', 00:52:45 INFO - 'tpaint', 00:52:45 INFO - 'sessionrestore', 00:52:45 INFO - 'sessionrestore_no_auto_restore']}, 00:52:45 INFO - 'other_l64': {'tests': ['a11yr', 00:52:45 INFO - 'ts_paint', 00:52:45 INFO - 'tpaint', 00:52:45 INFO - 'sessionrestore', 00:52:45 INFO - 'sessionrestore_no_auto_restore']}, 00:52:45 INFO - 'other_nol64': {'tests': ['a11yr', 00:52:45 INFO - 'ts_paint', 00:52:45 INFO - 'tpaint', 00:52:45 INFO - 'sessionrestore', 00:52:45 INFO - 'sessionrestore_no_auto_restore']}, 00:52:45 INFO - 'svgr': {'tests': ['tsvgx', 00:52:45 INFO - 'tsvgr_opacity', 00:52:45 INFO - 'tart', 00:52:45 INFO - 'tscrollx', 00:52:45 INFO - 'cart']}, 00:52:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:52:45 INFO - 'tests': ['tsvgx', 00:52:45 INFO - 'tsvgr_opacity', 00:52:45 INFO - 'tart', 00:52:45 INFO - 'tscrollx', 00:52:45 INFO - 'cart']}, 00:52:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:45 INFO - 'tests': ['tp5o']}, 00:52:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:45 INFO - 'talos_options': ['--e10s'], 00:52:45 INFO - 'tests': ['tp5o']}, 00:52:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:45 INFO - 'talos_options': ['--xperf_path', 00:52:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:45 INFO - 'tests': ['tp5n']}, 00:52:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:52:45 INFO - 'talos_options': ['--e10s', 00:52:45 INFO - '--xperf_path', 00:52:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:52:45 INFO - 'tests': ['tp5n']}}, 00:52:45 INFO - 'talos.zip': {'path': '', 00:52:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:52:45 INFO - Running post-action listener: _resource_record_post_action 00:52:45 INFO - ##### 00:52:45 INFO - ##### Running create-virtualenv step. 00:52:45 INFO - ##### 00:52:45 INFO - Running pre-action listener: _resource_record_pre_action 00:52:45 INFO - Running main action method: create_virtualenv 00:52:45 INFO - Creating virtualenv /builds/slave/test/build/venv 00:52:45 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 00:52:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:52:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:52:45 INFO - Using real prefix '/usr' 00:52:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:52:46 INFO - Installing distribute.............................................................................................................................................................................................done. 00:52:48 INFO - Installing pip.................done. 00:52:48 INFO - Return code: 0 00:52:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f005ada4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, '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': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', '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 00:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:52:48 INFO - Using env: {'DISPLAY': ':0', 00:52:48 INFO - 'HOME': '/home/cltbld', 00:52:48 INFO - 'LANG': 'en_US.UTF-8', 00:52:48 INFO - 'LANGUAGE': 'en_US:en', 00:52:48 INFO - 'LOGNAME': 'cltbld', 00:52:48 INFO - 'MAIL': '/var/mail/cltbld', 00:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:48 INFO - 'MOZ_NO_REMOTE': '1', 00:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:48 INFO - 'NO_EM_RESTART': '1', 00:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:48 INFO - 'PWD': '/builds/slave/test', 00:52:48 INFO - 'SHELL': '/bin/bash', 00:52:48 INFO - 'SHLVL': '1', 00:52:48 INFO - 'TERM': 'linux', 00:52:48 INFO - 'TMOUT': '86400', 00:52:48 INFO - 'USER': 'cltbld', 00:52:48 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:48 INFO - '_': '/tools/buildbot/bin/python'} 00:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:48 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 00:52:48 INFO - Cleaning up... 00:52:48 INFO - Return code: 0 00:52:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f005ada4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, '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': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', '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 00:52:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 00:52:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 00:52:48 INFO - Using env: {'DISPLAY': ':0', 00:52:48 INFO - 'HOME': '/home/cltbld', 00:52:48 INFO - 'LANG': 'en_US.UTF-8', 00:52:48 INFO - 'LANGUAGE': 'en_US:en', 00:52:48 INFO - 'LOGNAME': 'cltbld', 00:52:48 INFO - 'MAIL': '/var/mail/cltbld', 00:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:48 INFO - 'MOZ_NO_REMOTE': '1', 00:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:48 INFO - 'NO_EM_RESTART': '1', 00:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:48 INFO - 'PWD': '/builds/slave/test', 00:52:48 INFO - 'SHELL': '/bin/bash', 00:52:48 INFO - 'SHLVL': '1', 00:52:48 INFO - 'TERM': 'linux', 00:52:48 INFO - 'TMOUT': '86400', 00:52:48 INFO - 'USER': 'cltbld', 00:52:48 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:48 INFO - '_': '/tools/buildbot/bin/python'} 00:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:48 INFO - Downloading/unpacking psutil>=0.7.1 00:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:52:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:52:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:52:50 INFO - Installing collected packages: psutil 00:52:50 INFO - Running setup.py install for psutil 00:52:50 INFO - building 'psutil._psutil_linux' extension 00:52:50 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 00:52:50 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 00:52:50 INFO - building 'psutil._psutil_posix' extension 00:52:50 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 00:52:50 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 00:52:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:52:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:52:50 INFO - Successfully installed psutil 00:52:50 INFO - Cleaning up... 00:52:50 INFO - Return code: 0 00:52:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:50 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 0x7f005ada4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, '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': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', '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 00:52:50 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 00:52:50 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 00:52:50 INFO - Using env: {'DISPLAY': ':0', 00:52:50 INFO - 'HOME': '/home/cltbld', 00:52:50 INFO - 'LANG': 'en_US.UTF-8', 00:52:50 INFO - 'LANGUAGE': 'en_US:en', 00:52:50 INFO - 'LOGNAME': 'cltbld', 00:52:50 INFO - 'MAIL': '/var/mail/cltbld', 00:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:50 INFO - 'MOZ_NO_REMOTE': '1', 00:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:50 INFO - 'NO_EM_RESTART': '1', 00:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:50 INFO - 'PWD': '/builds/slave/test', 00:52:50 INFO - 'SHELL': '/bin/bash', 00:52:50 INFO - 'SHLVL': '1', 00:52:50 INFO - 'TERM': 'linux', 00:52:50 INFO - 'TMOUT': '86400', 00:52:50 INFO - 'USER': 'cltbld', 00:52:50 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:50 INFO - '_': '/tools/buildbot/bin/python'} 00:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:52:51 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 00:52:51 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 00:52:51 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 00:52:51 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 00:52:51 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 00:52:51 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 00:52:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:52:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:52:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:52:52 INFO - Installing collected packages: mozsystemmonitor 00:52:52 INFO - Running setup.py install for mozsystemmonitor 00:52:52 INFO - Successfully installed mozsystemmonitor 00:52:52 INFO - Cleaning up... 00:52:52 INFO - Return code: 0 00:52:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:52:52 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')]} 00:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:52 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')]} 00:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:52 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 0x7f005ada4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, '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': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', '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 00:52:52 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 00:52:52 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 00:52:52 INFO - Using env: {'DISPLAY': ':0', 00:52:52 INFO - 'HOME': '/home/cltbld', 00:52:52 INFO - 'LANG': 'en_US.UTF-8', 00:52:52 INFO - 'LANGUAGE': 'en_US:en', 00:52:52 INFO - 'LOGNAME': 'cltbld', 00:52:52 INFO - 'MAIL': '/var/mail/cltbld', 00:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:52 INFO - 'MOZ_NO_REMOTE': '1', 00:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:52 INFO - 'NO_EM_RESTART': '1', 00:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:52 INFO - 'PWD': '/builds/slave/test', 00:52:52 INFO - 'SHELL': '/bin/bash', 00:52:52 INFO - 'SHLVL': '1', 00:52:52 INFO - 'TERM': 'linux', 00:52:52 INFO - 'TMOUT': '86400', 00:52:52 INFO - 'USER': 'cltbld', 00:52:52 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:52 INFO - '_': '/tools/buildbot/bin/python'} 00:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:53 INFO - Downloading/unpacking blobuploader==1.2.4 00:52:53 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 00:52:53 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 00:52:53 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 00:52:53 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 00:52:53 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 00:52:53 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 00:52:54 INFO - Downloading blobuploader-1.2.4.tar.gz 00:52:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:52:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:52:54 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 00:52:54 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 00:52:54 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 00:52:54 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 00:52:54 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 00:52:54 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 00:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:52:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:52:55 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 00:52:55 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 00:52:55 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 00:52:55 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 00:52:55 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 00:52:55 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 00:52:55 INFO - Downloading docopt-0.6.1.tar.gz 00:52:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:52:55 INFO - Installing collected packages: blobuploader, requests, docopt 00:52:55 INFO - Running setup.py install for blobuploader 00:52:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:52:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:52:55 INFO - Running setup.py install for requests 00:52:56 INFO - Running setup.py install for docopt 00:52:56 INFO - Successfully installed blobuploader requests docopt 00:52:56 INFO - Cleaning up... 00:52:56 INFO - Return code: 0 00:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:52:56 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')]} 00:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:56 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')]} 00:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52:56 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 0x7f005ada4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, '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': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', '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 00:52:56 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 00:52:56 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 00:52:56 INFO - Using env: {'DISPLAY': ':0', 00:52:56 INFO - 'HOME': '/home/cltbld', 00:52:56 INFO - 'LANG': 'en_US.UTF-8', 00:52:56 INFO - 'LANGUAGE': 'en_US:en', 00:52:56 INFO - 'LOGNAME': 'cltbld', 00:52:56 INFO - 'MAIL': '/var/mail/cltbld', 00:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:56 INFO - 'MOZ_NO_REMOTE': '1', 00:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:56 INFO - 'NO_EM_RESTART': '1', 00:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:56 INFO - 'PWD': '/builds/slave/test', 00:52:56 INFO - 'SHELL': '/bin/bash', 00:52:56 INFO - 'SHLVL': '1', 00:52:56 INFO - 'TERM': 'linux', 00:52:56 INFO - 'TMOUT': '86400', 00:52:56 INFO - 'USER': 'cltbld', 00:52:56 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:56 INFO - '_': '/tools/buildbot/bin/python'} 00:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:52:56 INFO - Running setup.py (path:/tmp/pip-VEooVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:52:56 INFO - Running setup.py (path:/tmp/pip-L1Nwn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:52:56 INFO - Running setup.py (path:/tmp/pip-VY_xfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:52:56 INFO - Running setup.py (path:/tmp/pip-PGFCQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:52:56 INFO - Running setup.py (path:/tmp/pip-FSQolf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:52:56 INFO - Running setup.py (path:/tmp/pip-Un_q7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:52:56 INFO - Running setup.py (path:/tmp/pip-nXuZ3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:52:56 INFO - Running setup.py (path:/tmp/pip-4Uj4oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:52:56 INFO - Running setup.py (path:/tmp/pip-b7bTBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:52:57 INFO - Running setup.py (path:/tmp/pip-AnLoNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:52:57 INFO - Running setup.py (path:/tmp/pip-cbjxj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:52:57 INFO - Running setup.py (path:/tmp/pip-MClqG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:52:57 INFO - Running setup.py (path:/tmp/pip-WDttdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:52:57 INFO - Running setup.py (path:/tmp/pip-qKF6GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:57 INFO - Running setup.py (path:/tmp/pip-wCQCQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:52:57 INFO - Running setup.py (path:/tmp/pip-ev7vtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:52:57 INFO - Running setup.py (path:/tmp/pip-cDW_aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:52:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:52:57 INFO - Running setup.py install for manifestparser 00:52:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:52:57 INFO - Running setup.py install for mozcrash 00:52:57 INFO - Running setup.py install for mozdebug 00:52:57 INFO - Running setup.py install for mozdevice 00:52:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Running setup.py install for mozfile 00:52:58 INFO - Running setup.py install for mozhttpd 00:52:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Running setup.py install for mozinfo 00:52:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Running setup.py install for mozInstall 00:52:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Running setup.py install for mozleak 00:52:58 INFO - Running setup.py install for mozlog 00:52:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Running setup.py install for moznetwork 00:52:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Running setup.py install for mozprocess 00:52:58 INFO - Running setup.py install for mozprofile 00:52:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:52:58 INFO - Running setup.py install for mozrunner 00:52:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:52:59 INFO - Running setup.py install for mozscreenshot 00:52:59 INFO - Running setup.py install for moztest 00:52:59 INFO - Running setup.py install for mozversion 00:52:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:52:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:52:59 INFO - Cleaning up... 00:52:59 INFO - Return code: 0 00:52:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:52: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')]} 00:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:52:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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')]} 00:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:52:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:52: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', '-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 0x7f005ada4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, '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': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', '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 00:52:59 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 00:52:59 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 00:52:59 INFO - Using env: {'DISPLAY': ':0', 00:52:59 INFO - 'HOME': '/home/cltbld', 00:52:59 INFO - 'LANG': 'en_US.UTF-8', 00:52:59 INFO - 'LANGUAGE': 'en_US:en', 00:52:59 INFO - 'LOGNAME': 'cltbld', 00:52:59 INFO - 'MAIL': '/var/mail/cltbld', 00:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:52:59 INFO - 'MOZ_NO_REMOTE': '1', 00:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:52:59 INFO - 'NO_EM_RESTART': '1', 00:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:52:59 INFO - 'PWD': '/builds/slave/test', 00:52:59 INFO - 'SHELL': '/bin/bash', 00:52:59 INFO - 'SHLVL': '1', 00:52:59 INFO - 'TERM': 'linux', 00:52:59 INFO - 'TMOUT': '86400', 00:52:59 INFO - 'USER': 'cltbld', 00:52:59 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:52:59 INFO - '_': '/tools/buildbot/bin/python'} 00:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:52:59 INFO - Running setup.py (path:/tmp/pip-y5MAdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:52:59 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)) 00:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:52:59 INFO - Running setup.py (path:/tmp/pip-P9QnKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:52:59 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)) 00:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:52:59 INFO - Running setup.py (path:/tmp/pip-ftqDMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:52:59 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)) 00:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:52:59 INFO - Running setup.py (path:/tmp/pip-9fBRQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:52:59 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)) 00:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:52:59 INFO - Running setup.py (path:/tmp/pip-FV7S1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:52:59 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)) 00:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:52:59 INFO - Running setup.py (path:/tmp/pip-UlIyFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:53:00 INFO - Running setup.py (path:/tmp/pip-EOJ03I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:53:00 INFO - Running setup.py (path:/tmp/pip-P9OUMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:53:00 INFO - Running setup.py (path:/tmp/pip-7sUA1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:53:00 INFO - Running setup.py (path:/tmp/pip-tSrY0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:53:00 INFO - Running setup.py (path:/tmp/pip-bhUJFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:53:00 INFO - Running setup.py (path:/tmp/pip-Gz8qTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:53:00 INFO - Running setup.py (path:/tmp/pip-hzDwuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:53:00 INFO - Running setup.py (path:/tmp/pip-_IwGmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:00 INFO - Running setup.py (path:/tmp/pip-l9Ynkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:53:00 INFO - Running setup.py (path:/tmp/pip-6IFxAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:53:00 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)) 00:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:53:00 INFO - Running setup.py (path:/tmp/pip-DwUElK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:53:00 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)) 00:53:00 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)) 00:53:00 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)) 00:53:00 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)) 00:53:00 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)) 00:53:00 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)) 00:53:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53: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 00:53:02 INFO - Downloading blessings-1.5.1.tar.gz 00:53:02 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 00:53:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:53:02 INFO - Installing collected packages: blessings 00:53:02 INFO - Running setup.py install for blessings 00:53:02 INFO - Successfully installed blessings 00:53:02 INFO - Cleaning up... 00:53:02 INFO - Return code: 0 00:53:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:53:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:53:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:53:02 INFO - Reading from file tmpfile_stdout 00:53:02 INFO - Current package versions: 00:53:02 INFO - argparse == 1.2.1 00:53:02 INFO - blessings == 1.5.1 00:53:02 INFO - blobuploader == 1.2.4 00:53:02 INFO - docopt == 0.6.1 00:53:02 INFO - manifestparser == 1.1 00:53:02 INFO - mozInstall == 1.12 00:53:02 INFO - mozcrash == 0.16 00:53:02 INFO - mozdebug == 0.1 00:53:02 INFO - mozdevice == 0.47 00:53:02 INFO - mozfile == 1.2 00:53:02 INFO - mozhttpd == 0.7 00:53:02 INFO - mozinfo == 0.9 00:53:02 INFO - mozleak == 0.1 00:53:02 INFO - mozlog == 3.1 00:53:02 INFO - moznetwork == 0.27 00:53:02 INFO - mozprocess == 0.22 00:53:02 INFO - mozprofile == 0.27 00:53:02 INFO - mozrunner == 6.11 00:53:02 INFO - mozscreenshot == 0.1 00:53:02 INFO - mozsystemmonitor == 0.0 00:53:02 INFO - moztest == 0.7 00:53:02 INFO - mozversion == 1.4 00:53:02 INFO - psutil == 3.1.1 00:53:02 INFO - requests == 1.2.3 00:53:02 INFO - wsgiref == 0.1.2 00:53:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:53: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')]} 00:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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')]} 00:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53: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', '-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 0x7f005ada4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, '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': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', '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 00:53:02 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 00:53:02 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 00:53:02 INFO - Using env: {'DISPLAY': ':0', 00:53:02 INFO - 'HOME': '/home/cltbld', 00:53:02 INFO - 'LANG': 'en_US.UTF-8', 00:53:02 INFO - 'LANGUAGE': 'en_US:en', 00:53:02 INFO - 'LOGNAME': 'cltbld', 00:53:02 INFO - 'MAIL': '/var/mail/cltbld', 00:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:02 INFO - 'MOZ_NO_REMOTE': '1', 00:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:02 INFO - 'NO_EM_RESTART': '1', 00:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:02 INFO - 'PWD': '/builds/slave/test', 00:53:02 INFO - 'SHELL': '/bin/bash', 00:53:02 INFO - 'SHLVL': '1', 00:53:02 INFO - 'TERM': 'linux', 00:53:02 INFO - 'TMOUT': '86400', 00:53:02 INFO - 'USER': 'cltbld', 00:53:02 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:02 INFO - '_': '/tools/buildbot/bin/python'} 00:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:03 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)) 00:53:03 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)) 00:53:03 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)) 00:53:03 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)) 00:53:03 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)) 00:53:03 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)) 00:53:03 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)) 00:53:03 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)) 00:53:03 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)) 00:53:03 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)) 00:53:03 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)) 00:53:03 INFO - Cleaning up... 00:53:03 INFO - Return code: 0 00:53:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:03 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 0x7f005ada4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, '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': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', '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 00:53:03 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 00:53:03 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 00:53:03 INFO - Using env: {'DISPLAY': ':0', 00:53:03 INFO - 'HOME': '/home/cltbld', 00:53:03 INFO - 'LANG': 'en_US.UTF-8', 00:53:03 INFO - 'LANGUAGE': 'en_US:en', 00:53:03 INFO - 'LOGNAME': 'cltbld', 00:53:03 INFO - 'MAIL': '/var/mail/cltbld', 00:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:03 INFO - 'MOZ_NO_REMOTE': '1', 00:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:03 INFO - 'NO_EM_RESTART': '1', 00:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:03 INFO - 'PWD': '/builds/slave/test', 00:53:03 INFO - 'SHELL': '/bin/bash', 00:53:03 INFO - 'SHLVL': '1', 00:53:03 INFO - 'TERM': 'linux', 00:53:03 INFO - 'TMOUT': '86400', 00:53:03 INFO - 'USER': 'cltbld', 00:53:03 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:03 INFO - '_': '/tools/buildbot/bin/python'} 00:53:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:03 INFO - Downloading/unpacking jsonschema 00:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:53:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:53:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:53:05 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 00:53:05 INFO - Downloading/unpacking functools32 (from jsonschema) 00:53:05 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 00:53:05 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 00:53:05 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 00:53:05 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 00:53:05 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 00:53:05 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 00:53:05 INFO - Downloading functools32-3.2.3-2.tar.gz 00:53:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:53:05 INFO - warning: no files found matching '*.txt' 00:53:05 INFO - no previously-included directories found matching 'build' 00:53:05 INFO - no previously-included directories found matching 'dist' 00:53:05 INFO - no previously-included directories found matching '.git*' 00:53:05 INFO - Installing collected packages: jsonschema, functools32 00:53:05 INFO - Running setup.py install for functools32 00:53:05 INFO - warning: no files found matching '*.txt' 00:53:05 INFO - no previously-included directories found matching 'build' 00:53:05 INFO - no previously-included directories found matching 'dist' 00:53:05 INFO - no previously-included directories found matching '.git*' 00:53:05 INFO - Successfully installed jsonschema functools32 00:53:05 INFO - Cleaning up... 00:53:05 INFO - Return code: 0 00:53:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:53:05 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 0x7f005ada4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, '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': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', '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 00:53:05 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 00:53:05 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 00:53:05 INFO - Using env: {'DISPLAY': ':0', 00:53:05 INFO - 'HOME': '/home/cltbld', 00:53:05 INFO - 'LANG': 'en_US.UTF-8', 00:53:05 INFO - 'LANGUAGE': 'en_US:en', 00:53:05 INFO - 'LOGNAME': 'cltbld', 00:53:05 INFO - 'MAIL': '/var/mail/cltbld', 00:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:05 INFO - 'MOZ_NO_REMOTE': '1', 00:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:05 INFO - 'NO_EM_RESTART': '1', 00:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:05 INFO - 'PWD': '/builds/slave/test', 00:53:05 INFO - 'SHELL': '/bin/bash', 00:53:05 INFO - 'SHLVL': '1', 00:53:05 INFO - 'TERM': 'linux', 00:53:05 INFO - 'TMOUT': '86400', 00:53:05 INFO - 'USER': 'cltbld', 00:53:05 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:05 INFO - '_': '/tools/buildbot/bin/python'} 00:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:53:05 INFO - Downloading/unpacking flake8 00:53:05 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 00:53:05 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 00:53:05 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 00:53:05 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 00:53:05 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 00:53:05 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 00:53:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:53:07 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 00:53:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:53:07 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 00:53:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:07 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 00:53:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:53:08 INFO - no previously-included directories found matching 'docs/_build' 00:53:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:53:08 INFO - Running setup.py install for pep8 00:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:53:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:53:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:53:08 INFO - no previously-included directories found matching 'docs/_build' 00:53:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:53:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:53:08 INFO - Cleaning up... 00:53:08 INFO - Return code: 0 00:53:08 INFO - Running post-action listener: _resource_record_post_action 00:53:08 INFO - Running post-action listener: _start_resource_monitoring 00:53:08 INFO - Starting resource monitoring. 00:53:08 INFO - ##### 00:53:08 INFO - ##### Running install step. 00:53:08 INFO - ##### 00:53:08 INFO - Running pre-action listener: _resource_record_pre_action 00:53:08 INFO - Running main action method: install 00:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:53:08 INFO - Reading from file tmpfile_stdout 00:53:08 INFO - Detecting whether we're running mozinstall >=1.0... 00:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:53:08 INFO - Reading from file tmpfile_stdout 00:53:08 INFO - Output received: 00:53:08 INFO - Usage: mozinstall [options] installer 00:53:08 INFO - Options: 00:53:08 INFO - -h, --help show this help message and exit 00:53:08 INFO - -d DEST, --destination=DEST 00:53:08 INFO - Directory to install application into. [default: 00:53:08 INFO - "/builds/slave/test"] 00:53:08 INFO - --app=APP Application being installed. [default: firefox] 00:53:08 INFO - mkdir: /builds/slave/test/build/application 00:53:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:53:23 INFO - Reading from file tmpfile_stdout 00:53:23 INFO - Output received: 00:53:23 INFO - /builds/slave/test/build/application/firefox/firefox 00:53:23 INFO - Running post-action listener: _resource_record_post_action 00:53:23 INFO - ##### 00:53:23 INFO - ##### Running run-tests step. 00:53:23 INFO - ##### 00:53:23 INFO - Running pre-action listener: _resource_record_pre_action 00:53:23 INFO - Running main action method: run_tests 00:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:53:23 INFO - Python 2.7.3 00:53:23 INFO - Return code: 0 00:53:23 INFO - grabbing minidump binary from tooltool 00:53:23 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')]} 00:53:23 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 0x25550b0>, '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 0x2555fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2556440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:53:23 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 00:53:23 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 00:53:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:53:23 INFO - Return code: 0 00:53:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:53:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:53:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:53:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:53:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:53:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:53:24 INFO - Return code: 0 00:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test/build 00:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 00:53:24 INFO - Using env: {'DISPLAY': ':0', 00:53:24 INFO - 'HOME': '/home/cltbld', 00:53:24 INFO - 'LANG': 'en_US.UTF-8', 00:53:24 INFO - 'LANGUAGE': 'en_US:en', 00:53:24 INFO - 'LOGNAME': 'cltbld', 00:53:24 INFO - 'MAIL': '/var/mail/cltbld', 00:53:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:53:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:53:24 INFO - 'MOZ_NO_REMOTE': '1', 00:53:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:53:24 INFO - 'NO_EM_RESTART': '1', 00:53:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:53:24 INFO - 'PWD': '/builds/slave/test', 00:53:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:53:24 INFO - 'SHELL': '/bin/bash', 00:53:24 INFO - 'SHLVL': '1', 00:53:24 INFO - 'TERM': 'linux', 00:53:24 INFO - 'TMOUT': '86400', 00:53:24 INFO - 'USER': 'cltbld', 00:53:24 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973', 00:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:53:24 INFO - '_': '/tools/buildbot/bin/python'} 00:53:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 00:53:24 INFO - mozversion INFO | application_buildid: 20151216235732 00:53:24 INFO - mozversion INFO | application_changeset: bb0e4752f9bbab121139b52ed6dbff7b5b1f08e2 00:53:24 INFO - mozversion INFO | application_display_name: Nightly 00:53:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:53:24 INFO - mozversion INFO | application_name: Firefox 00:53:24 INFO - mozversion INFO | application_remotingname: firefox 00:53:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 00:53:24 INFO - mozversion INFO | application_vendor: Mozilla 00:53:24 INFO - mozversion INFO | application_version: 46.0a1 00:53:24 INFO - mozversion INFO | platform_buildid: 20151216235732 00:53:24 INFO - mozversion INFO | platform_changeset: bb0e4752f9bbab121139b52ed6dbff7b5b1f08e2 00:53:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 00:53:24 INFO - mozversion INFO | platform_version: 46.0a1 00:53:24 INFO - 2015-12-17 00:53:24,843 DEBUG : using testdate: 1450342404 00:53:24 INFO - 2015-12-17 00:53:24,843 DEBUG : actual date: 1450342404 00:53:24 INFO - 2015-12-17 00:53:24,853 INFO : starting webserver on 'localhost:43098' 00:53:24 INFO - 2015-12-17 00:53:24,854 INFO : Starting test suite talos-linux64-ix-059 00:53:24 INFO - 2015-12-17 00:53:24,854 INFO : Starting test dromaeo_css 00:53:24 INFO - 2015-12-17 00:53:24,854 DEBUG : operating with platform_type : linux_ 00:53:24 INFO - 2015-12-17 00:53:24,855 INFO : Initialising browser for dromaeo_css test... 00:53:24 INFO - 2015-12-17 00:53:24,865 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6hSqbE/profile http://localhost:43098/getInfo.html 00:53:29 INFO - 2015-12-17 00:53:29,146 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:53:29 INFO - 2015-12-17 00:53:29,146 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:53:29 INFO - 2015-12-17 00:53:29,146 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:53:29 INFO - 2015-12-17 00:53:29,146 DEBUG : BROWSER_OUTPUT: __metrics 00:53:29 INFO - 2015-12-17 00:53:29,207 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 00:53:29 INFO - 2015-12-17 00:53:29,283 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] 00:53:29 ERROR - 2015-12-17 00:53:29,291 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 00:53:29 INFO - 2015-12-17 00:53:29,573 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 00:53:30 INFO - 2015-12-17 00:53:30,235 INFO : Browser initialized. 00:53:30 INFO - 2015-12-17 00:53:30,235 INFO : Running cycle 1/1 for dromaeo_css test... 00:53:30 INFO - 2015-12-17 00:53:30,235 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6hSqbE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:53:42 INFO - 2015-12-17 00:53:42,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 139874304 00:53:42 INFO - 2015-12-17 00:53:42,254 DEBUG : BROWSER_OUTPUT: 00:54:33 INFO - 2015-12-17 00:54:33,472 DEBUG : BROWSER_OUTPUT: 1450342473469 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] 00:56:45 INFO - 2015-12-17 00:56:45,283 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43098/tests/dromaeo/cssquery-ext.html) 00:56:46 INFO - 2015-12-17 00:56:46,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 255901696 00:56:46 INFO - 2015-12-17 00:56:46,394 DEBUG : BROWSER_OUTPUT: 00:59:48 INFO - 2015-12-17 00:59:48,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/dromaeo/cssquery-ext.html (next: http://localhost:43098/tests/dromaeo/cssquery-jquery.html) 00:59:49 INFO - 2015-12-17 00:59:49,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 222461952 00:59:49 INFO - 2015-12-17 00:59:49,434 DEBUG : BROWSER_OUTPUT: 01:02:51 INFO - 2015-12-17 01:02:51,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43098/tests/dromaeo/cssquery-mootools.html) 01:02:52 INFO - 2015-12-17 01:02:52,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 214224896 01:02:52 INFO - 2015-12-17 01:02:52,200 DEBUG : BROWSER_OUTPUT: 01:05:54 INFO - 2015-12-17 01:05:54,181 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43098/tests/dromaeo/cssquery-prototype.html) 01:05:54 INFO - 2015-12-17 01:05:54,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 200802304 01:05:54 INFO - 2015-12-17 01:05:54,771 DEBUG : BROWSER_OUTPUT: 01:08:57 INFO - 2015-12-17 01:08:57,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43098/tests/dromaeo/cssquery-yui.html) 01:08:58 INFO - 2015-12-17 01:08:58,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 206057472 01:08:58 INFO - 2015-12-17 01:08:58,010 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-12-17 01:12:00,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/dromaeo/cssquery-yui.html (next: http://localhost:43098/tests/dromaeo/cssquery-dojo.html) 01:12:00 INFO - 2015-12-17 01:12:00,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 255393792 01:12:00 INFO - 2015-12-17 01:12:00,770 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-12-17 01:12:00,771 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:12:00 INFO - 2015-12-17 01:12:00,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:12:00 INFO - 2015-12-17 01:12:00,771 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:12:00 INFO - 2015-12-17 01:12:00,771 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:12:00 INFO - 2015-12-17 01:12:00,771 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2594.6497222874914;2710.620513128162;2715.321169707573;2716.9320766980823;2733.4533093381324;4500.864974050775;4630.421197350332;4719.716816990978;4744.478107408187;4758.809647614095;4655.627549796017;4712.90574188516;4773.832915847937;4778.976105119478;4780.617550595953;4304.935425968613;4340.045190058182;4352.630026447756;4441.222786012451;4479.574440428154;4210.431591735107;4402.339649052636;4434.933475997863;4474.418325617665;4538.205813982539;4222.2188895054205;4288.463942007249;4289.099289149282;4300.096979634281;4314.482262128533;4375.387445757597;4391.538888416702;4394.802233899451;4416.381706561084;4423.447069116361;4156.896077598054;4249.596288352602;4357.542458041891;4384.123175364908;4442.178197033559;4586.931196032062;4634.791434385461;4702;4725.362076119714;4792.400949881265;5076.720780357079;5077.593792496591;5088.949110508885;5091.134507133796;5117.027764724728;4911.238757992481;5023;5105.566026887719;5107.361579802525;5107.642465027412;4645.442546894395;4666.626669866437;4711;4726.338312636233;4768.57082862544;5181.145111056709;5182.870428239325;5184.326037615161;5227.555657769056;5235.947640523622;4743.66794324394;4831.710097394168;4958.776855041532;4968.403791545038;4984.152694042022;4982.90034199314;5024.221245706921;5126.564242039469;5130.486951304914;5154.896902061938;5007.4491805901325;5022.196448568212;5031.698098114125;5046.394432668103;5076.36545431821;4805.1590971579835;4932.136876046678;4995.325631039836;4999.450060493343;5004.724740139254;4093.7134400592267;4124.1957818225155;4149.751014939114;4169.45797046382;4209.936850947238;3696.8336424860945;3718.460823180678;3719.8698045568276;3737.1404576947452;3747.38168202249;4180.519240287406;4271.081717430768;4370.147821174904;4420.955790442119;4452.777361131995;4998.550130488274;5034.949650503448;5070.7464626768515;5109.846704598868;5118;4300.89247768802;4318.3090705486975;4330.35044743291;4332.0469496710675;4363.47638283408;4501.392312037899;4505.256632655575;4508.954910450919;4529.569690879362;4544.84093056748;4658.767061646904;4770.928436073531;4771.021940502258;4771.976140119277;4884.535969082932;5084.466131056186;5094.337736094284;5102.795888164432;5107.87230319245;5140.997505486394;4823.879403014953;4825.734584597881;4829.396325459317;4843.07981483517;4886.340344053508;4739.976300118477;4844.32179494864;4845.636577256791;5004.424491183415;5121.487851214849;5113.565346945403;5115.437301896863;5121.74391280442;5125.589952803842;5126.154184559655;4909.410870695397;4924.82763103304;4927.211646136601;4928.11293967075;4960.404751429852;4590.127875703605;4760.452547957029;4785.162596545661;4878.341423907727;4928.457869634266;4826.348442960296;4848.981713839992;4854;4877.756112194305;4898.583620392306;4897.485763994871;4970.62720295972;4977.253411988231;4995.2507123930245;5013.623978201576;4615.676902616785;4736.17117004516;4737.810487580458;4742.359781429601;4846.103470857903 01:12:00 INFO - 2015-12-17 01:12:00,773 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.8061678412555;559.5271995164086;560.1597603594608;560.5683623609821;567.5176100314735;26407.20778376647;27025.324366890836;33035.17412064697;33170.33659326812;33205.339733013374;38886.22227555447;39403.80298098513;39425.80287098567;39458;39473.40789888154;6874.415674667659;7845.13703492614;8033.95983020087;8042.2359875812;8053.114157442706;7019.929800702004;7122.323379278961;7126.429885609165;7126.821829454253;9816.116549510543;9887.11016008559;9958.502074896262;9965.252606054539;9966.800663986753;9976.850347244797;9834.409935403863;9914.752131196705;9922.156616687555;9928.50357482123;9964;7202.855942881113;7435.85128297431;7438.070241219848;7439.107307123126;10126.54430550627;37173.442398364044;37651.24697506035;37699.81150094232;37740.81129594362;37807.243855122746;2867.7419032286984;2916.985415072911;2981.1354707134906;2988.5068963620975;3043.46739320618;27169.728302716918;28467.57298640522;28596.428071438455;28605.28486787847;29215.123546293646;3124.875004999797;3148.496240601493;3151.4642510773224;3167.9683203168133;3184.586003819512;209790;210653;210854;211270;211761.99999999846;54984;55183;55322.17016744752;55324;55572;57657;58083;58187;58214.417855821746;58297;14260.714785704227;14857.851421485862;14901.403943842342;14923.328450219766;14937.551873443814;11358.26171298863;11441.771164576661;11446.656600302003;11448.370339631234;11461.426928653535;18997.525061873286;19004.61990760177;19124;19124.80875191258;19159.61680766377;7207.783766487014;7556.508826926232;7563.457095668345;7602.695892164252;7617.961910190525;845.691322667222;900.8378491871526;965.1940629574384;1028.7633844215723;1031.973186679259;26704.732952670613;26762.464750704876;26974.730252697223;27143.32141696434;27199.1840244793;884.4958373727043;966.5022513405602;971.7376308396694;981.1562056631292;1071.8767341755643;12685.14357053683;13076.934615327053;13550.45798168082;13551.39018744159;13648.93175534116;253678;255235;258664;258873;259242;46453.30320045202;46877.29684054742;46888.29667554989;46901.5309846904;46948.06103877904;1124.5726623882872;1125.0324720740157;1204.8975837053774;1211.1340391619858;1239.9380030998595;25396.873015634803;27482.17553473399;29231;29391.26521836971;29751;40297.59702402938;40548.33694125096;40581.594184058966;40599.39100913548;40616.187676246904;199499;221463;223681.88159059102;322527;335953;26943.595846062715;27020;27040.72959270382;27126.321841954108;27447.45105097847;36826.63173368232;38921.80539097286;39595.80202098971;39844.80077599709;40039.39940900947;31562.36875262528;32511.83744081359;32561.674383256814;33019.66980330166;33300;32036.19909502281;32372.514412283363;32548;32728.50907236441;32789;32256.516152258206;32646.51030234596;32899.34201316008;32913.177170570925;33139.50290745689;28293.292667683472;29292.560611590416;30785.64057786961;32883.50674739833;33066.173345665586;23365.182218622267;23681.17115900935;24025.639615405435;25696;26200.475990479703 01:12:00 INFO - 2015-12-17 01:12:00,774 DEBUG : BROWSER_OUTPUT: |2;jquery.html;325.4418671977559;333.23522515826176;333.9332133573286;335.89561397842516;337.9526866238725;12638.557650482235;12871.420786064626;14461.20463374514;14942.477013304537;15161.848381516182;12626.431810568523;15149.77275340868;15170.772438413433;15612.141332226724;15631.92184039081;4983.028309479653;4996.825111121102;5120.974395128019;5135.486451354872;5157.767900444489;3452.2577645806145;3555.342261681584;4899.191633380488;5125.871853203663;5143.305653736735;5035.118854200518;5076.03555324489;5078.365204349457;5080.949190508085;5085.389753229618;5027.547520723134;5040.697558146505;5084.262781896623;5734.225879506255;5742.081266997302;5096.847094587169;5100.795968161269;5102.081625307444;5104.285400043959;5105.617078719111;11284.210105292634;11790.292582445081;12235.388230588524;12246.203996740183;12257.203281786655;1772.1139430284857;1790.713485842259;1793.1213705284447;1854.6568884756364;1964.6758284882976;8741.562921853945;9064.184223419858;9127.5436228189;9138.223251023672;10537.9473102634;1682.2093616000461;1754.9385771497937;1785.2234278088943;1804.2422182683174;1818.3544841581313;55570.72214638942;56663.15005274924;56894;58414.41585584175;58438.70780646112;9876.308658393988;9987.350822196535;9994.600215991424;10027.997200280059;10106.090451859222;12668.176568523017;12690.238585684889;12697.238165710087;12702.491900323883;12711.682207944876;7258.818529536698;7268.636568171571;7288.453365997571;7327.596982166032;7333.669984850694;7075;7079.079719636415;7102.254263302382;7156.177039640404;7156.355927966508;4197.811098500575;4201.516825565038;4220.092680073799;4255.680823938155;4296.398504209413;1519.5821149183841;1568.5372815019596;1691.4333698210992;1713.8260291700226;1737.114071823354;378.3228021840929;382.8526017483289;851.2253848997383;866.2463656618781;970.2674480767117;9724.873329802322;10058.849117263248;10080.193584513221;10082.747931301776;10151.7462063449;364.79753736675866;406.8982754311422;419.130304617919;419.53431690823163;424.60299619855533;5395.190721391823;5537.501624853782;5616.550675945996;5636.323641163005;5649.096144616841;473469.63265184144;474412;479803;482916;495068;72621;76032;76406.6179669098;76551.23448765441;78693.60653196697;1063.9202059845543;1074.5916551710457;1076.3649446826566;1100.1199040767353;1101.7961677089604;14683.19242441676;14761;14836.554903352917;15078.924605376902;15247.618809529851;33351.83268585588;33380;33820.492692609136;33994.320113598085;34139;45127.7743611293;45605.439456054126;46869;47330;47399.52600473951;8692.217700406994;8868.512231827312;8910.331725120512;8913.153250441197;8913.420627659441;10145.34055286404;10363.75634923814;10415.323004004715;10422.478876056319;10548.947255263674;9450.527473626154;9466;9507.429554226768;9511.476868772284;9595.664151754656;9608.807823843345;9725.562349694423;9758.121769040821;9776.755581110529;9891.851622225817;7891.210878912063;9695.951520242354;9714.3199976001;9807;9917.900820991987;11367.54529818798;11770.52917883275;11833.822492662444;13638.249896255802;14238.715225695221;9358.719238422858;9490.952545237229;9751.171150452292;9762.316637835283;14752.55742327732 01:12:00 INFO - 2015-12-17 01:12:00,775 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1223.7980733179027;1648.8763342749294;1701.8042925063614;1723.1556537296724;1731.7662115614396;6156.138140660306;6726.831829204266;7099.361057504823;7106.467014973872;7113.644317784103;6904.965475172629;6934.757283495079;6988.126484189476;6990.545614535052;6997.685104170312;2036.2364113457454;2060.7836177201402;2063.411927600634;2064.6593312103487;2065.1532871522677;2013.5872146210065;2018.3541266794632;2049.80526849949;2098.213170061227;2109.662454007359;2046.0690385874466;2119.9718136703686;2139.882306473143;2154.9030293636824;2155.4503601581655;2100.5693832764246;2129.8935053247274;2130.2011745595323;2132.7973842485017;2133.296012315932;2061.4537147655883;2096.1615353858424;2097.2345094040716;2099.391176558796;2103.379503046605;7211.387032102225;7271.927280727231;7295.416366690705;7320.194778574352;7322.304381083789;4236.661067114624;4307.418498502693;4309.052008558144;4309.762963037032;4320.9135817283795;2728.386113124551;2734.357426004887;2767.059199872033;2778.749912507864;2803.4393121375806;877.4472082587993;1545.8995165314332;1554.2384231726485;1556.2218890554723;1575.6139745762248;9626.278029147772;9785;9812.705618831447;9825.361351512129;9833.26250531206;3819.579846216914;3861.8607510784386;3869.96130038696;3881.204353107606;3939.6651284641125;7892.131865494791;7898.60506974649;7909.920900791033;7911.5253084815095;7930.206979302024;4214;4224.936625950613;4227.556106608823;4228.9788551057045;4235.174141042528;3286.622038465607;3418.9145271368416;3781.716371272166;3901.239258344652;3903.0437542802197;3278.49183376577;3311.8840840570947;3345.063382252973;3345.247319353126;3352.8826491072696;969.8351280282369;980.07872599756;983.4246965525248;989.5744829723288;991.137710192123;885.2165833237631;895.6596493332622;934.5887809363858;1209.0992210803008;1212.8120141378101;6841.93158068413;6924.307569243036;6931.1682598088555;6950.617716025566;6972.616506092112;408.2549347440873;409.6845429019698;413.3304047443101;413.52857742173944;414.22126402363364;5484.040292948718;5527.2538207342295;5536.640118392292;5547.223388725582;5547.55619550435;8435.451695639886;8438.451500652438;8576.44253123545;8589.398742087993;8626.266767324722;8502.574871256413;8525.232729054414;8568.914310856937;8604.225619694258;8609.827803443895;6650.83372915681;6811.352921472353;6851.143607049119;6906.896396554056;6977.232504424509;6904.27505111956;6972.860542789217;6993.930060699531;6995.265497122728;6999.230084690578;7774.650140743567;7913.129555748978;7915.208479152038;7995.600219988861;8024.077231118263;7584.4311676625575;7780.299773020455;7826;7842.568658723825;8194;5405.918911216414;6070.423309785563;6226.346233645402;6310.021946598285;6332.050192471166;6904.758333458506;6917.723291068301;6963.025176475398;6966.616836074065;6972.372486476242;6463.418292353711;6623.205215374186;6639.601623902581;6639.800805975829;6702.865942681216;6274.811755647338;6344.555881088464;6426.260979987362;6427.807165785034;6507.186601674791;6599.835004124935;6622.867542649216;6647.202335719745;6651.700673469609;6653.234877989094;5770.971145144247;6058.606190597597;6114.327423983447;6148.292946311231;6150;5900.822975310747;6214.751409943552;6214.8135555933395;6232.065190221503;6236.656983865931 01:12:00 INFO - 2015-12-17 01:12:00,776 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.37790816606554;291.64128122409437;292.0755807868098;295.8565095928475;302.05306364547135;5274.55166310864;5327.254184414185;5348.277982472365;5415.456594870463;5464.590155738316;5327.387350454689;5334.546563542103;5338.252644629755;5340.279062326585;5341.919871201935;4161.646260067891;4168.124693814288;4168.374743788441;4170.4578404807335;4175.979120104395;4141.792910354486;4170.812313445887;4172.958270417303;4178.791060446981;4180.686448516373;4039.313316736162;4117.608827161415;4138.896527586804;4140.254754144253;4145.419641250227;4123.587641235852;4124.979375103106;4133.111381053073;4133.6693064554765;4140.68944829136;3622.3117607654463;3626.7279954003293;3629.6007439181667;3630.09247688078;3637.636236376368;5099.821506247264;5129.9230511542355;5133.974330128362;5137.306463627438;5146.485351464861;4703.905921881577;4746.833860814855;4748.501407352247;4751.857444276678;4752.405949256343;5436.293281873371;5580.38615752271;5592.105263157916;5592.86017849553;5599.188117722907;3959.089409435846;3961.0493481564504;3964.5837187095226;3966.147278335172;3972.086420123359;5586.525145362649;5789.2763404574425;5881.558883083743;5888.617239879394;5897.380775018604;3937.901552461154;4046.9392959105635;4057.4522439470884;4073.837046518165;4084.7957602119777;4102.220578090153;4123.525794533607;4126;4128.3601041838565;4142.958570414317;4434;4564.246899261651;4609.216433206363;4703.7883295251795;4722.881927951828;5595.188697638901;5602.159676048625;5607.102863541813;5608.579356548275;5616.1014237721765;1437.755581551139;1463.2829913342598;1464.0703153497607;1465.7728052151933;1466.933987970544;979.7341981120544;988.6885631026204;994.2791476179711;1001.4892404873567;1005.1757558801859;4942.555170034714;4943.6786608871025;4944.159492886218;4952.257161425815;4956.405231372259;5811.041178205549;5811.767529298781;5813.563982701315;5816.5055970243;5817.912731309034;4926.285688575136;4933;4935.333729946411;4937.481564435682;4938.777755000961;3058.270175195913;3078.3843231353817;3101.3952279305317;3125.3749250150063;3131.3424180921807;5493.945060549343;5495.697736624444;5499.120140777536;5502.8349149525575;5503.752331145108;5934.970325148347;5935.970320148372;5940.70296485174;5942.465178133989;5944.019236825875;5487.259220005249;5487.506124448819;5488.725563721798;5491.066518691752;5492.450754924475;5606.551475882001;5788.479036886701;5812.796552120655;5816.360200377871;5818.301803783404;5656.830295091154;5668.971655141698;5674.148877668383;5674.319081710221;5674.631148975303;5506.779728810803;5515.779368825202;5519.227308176778;5520.1167813149705;5520.365158006881;3924.6271604197555;4006.318925782682;4007.3988901663815;4021.276170289259;4025.275450418953;5583.664980101207;5768.94231057684;5792.913106303493;5804.24544809189;5805.448482394166;5459.508644222039;5612.550995920398;5626.240457538343;5645.745941432728;5663.886722265449;5654.802081927113;5654.886902262014;5658.462446067617;5671.347795003462;5674.347450043298;5411;5510.586705996986;5528;5547.223388725501;5548.916766248591;5712.228849105484;5712.257406537124;5715.485606295453;5716.9428305718075;5718.914216286842;5551.084071128219;5562.137868630369;5568.91646625309;5578.609497335147;5579.77680892776 01:12:00 INFO - 2015-12-17 01:12:00,777 DEBUG : BROWSER_OUTPUT: |5;yui.html;652.1782553981983;691.0222035819315;742.4913933955238;751.654239050037;754.6000619671572;11776.11679124066;11920.523179072838;11957.701057473567;11958;11976.22154559953;11314.717132071682;11623.01204397625;11765.705857353549;11770.234934729237;11781.941090294536;807.7697856110995;815.1725998111921;815.3110621524802;815.7960509872532;817.6606708216083;795.32397462157;797.4975765267873;799.4923223752901;800.3997002248313;802.5826570183501;837.7068026190815;840.7771940435789;840.9537475438848;841.8105926166625;841.9158084191594;829.4525613095389;829.8132920092961;832.8750687396879;833.6832003838533;837.5853952293623;611.9908201376983;617.3517806303364;617.7035023188895;619.3249358199539;621.1738387944024;10834.40410777407;10967.616133435371;10970.670879873616;10988.450577471174;10999.890001100046;9459.337846350758;9740;9854.113129818279;9979.900200998043;10148.847767283496;7921.56431396273;8304.83390332196;8424;8466.74599762008;8482.53346065966;3134.4828103362915;3221.6617255188103;3235.9352812943844;3236.96763032369;3268.82021488818;36444;37124.628753712655;37225.627743722485;37298.62701372978;38274.42588361205;9177.219936305355;9224.723258302261;9406.95296523513;9491.054333861543;9498.620055197714;15180.696386072217;15217.31522081509;15228.543143705707;15240.161791101596;15250.923745381202;6161.260648722182;6287.1198032275515;6378.17083779115;6443.452306553995;6451.161349024691;3063.081075677288;3320.568326117589;3393.372226138172;3421.26442814791;3488.110531814371;2560.948781024369;2583.3412479817525;2584.1213987244428;2586.4439145583788;2591.4039770852432;461.5177139888824;469.9718016918996;470.5365215262963;475.4342332624166;476.0764117611822;573.8909607174623;607.4229481992126;614.9600275982046;622.7602373086395;634.1914059573987;7818.100918394343;8065.516069035877;8125.309348705308;8132.349412047022;8358.205970432798;529.4493726524372;532;532.3718012744921;562.7242651100931;622.757124721359;3774.226283611853;3903.1022864741267;4069.9389509157386;4088.4276201331836;4165.791710414528;41760.79119604443;42090;42213.78893105515;42271.7886410566;42361.364579531335;38021.80989095037;38585;38680.22639547193;38837.22325553473;38979;31655.733770649378;38157.42763858545;39081.80459097686;39919.60080399159;40101.398479022835;8029.4379393441895;8195.139510351328;8341.499510029418;8342.708005219789;8386.32909367237;31132.533012004384;31287;31986.36027279488;32009.8399508001;32127.839360803046;31644;37044;39268;39376;39464.40803388009;10081.294309398565;10085.344452610558;10094.949525252327;10181.796364072825;10246.846297305397;11172.217944744116;11354.886451135382;11438.370889601152;11590.88409115898;11779.941100294443;10385;10752.731181720206;10911.672649820519;11157.163212758913;11273.887261127284;10206.54070566841;10224.079832815083;10408.843867342148;10637.574497020032;10656.467176641292;10443.895561044596;10850.457477125954;10857.945710271399;10878.238523303293;10963.616273430393;9480.146786789222;9493.240540756584;9507.88580555012;9780.951095244478;9930.106290433896;8985.191332780081;9048.864267035868;9277.350585458953;9366.454535001649;9460.810783784149 01:12:00 INFO - 2015-12-17 01:12:00,778 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:12:00 INFO - 2015-12-17 01:12:00,778 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:12:00 INFO - 2015-12-17 01:12:00,778 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,927 01:12:00 INFO - 2015-12-17 01:12:00,778 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:12:00 INFO - 2015-12-17 01:12:00,778 DEBUG : BROWSER_OUTPUT: __startTimestamp1450343520770__endTimestamp 01:12:00 INFO - 2015-12-17 01:12:00,778 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-12-17 01:12:00,778 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:12:00 INFO - 2015-12-17 01:12:00,779 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:12:00 INFO - 2015-12-17 01:12:00,780 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-12-17 01:12:00,780 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4659.58 Median:4771.98 stddev:489.32 (10.3%) stddev-sans-first:463.23 01:12:00 INFO - 2015-12-17 01:12:00,780 DEBUG : BROWSER_OUTPUT: Values: 2594.6 2710.6 2715.3 2716.9 2733.5 4500.9 4630.4 4719.7 4744.5 4758.8 4655.6 4712.9 4773.8 4779.0 4780.6 4304.9 4340.0 4352.6 4441.2 4479.6 4210.4 4402.3 4434.9 4474.4 4538.2 4222.2 4288.5 4289.1 4300.1 4314.5 4375.4 4391.5 4394.8 4416.4 4423.4 4156.9 4249.6 4357.5 4384.1 4442.2 4586.9 4634.8 4702.0 4725.4 4792.4 5076.7 5077.6 5088.9 5091.1 5117.0 4911.2 5023.0 5105.6 5107.4 5107.6 4645.4 4666.6 4711.0 4726.3 4768.6 5181.1 5182.9 5184.3 5227.6 5235.9 4743.7 4831.7 4958.8 4968.4 4984.2 4982.9 5024.2 5126.6 5130.5 5154.9 5007.4 5022.2 5031.7 5046.4 5076.4 4805.2 4932.1 4995.3 4999.5 5004.7 4093.7 4124.2 4149.8 4169.5 4209.9 3696.8 3718.5 3719.9 3737.1 3747.4 4180.5 4271.1 4370.1 4421.0 4452.8 4998.6 5034.9 5070.7 5109.8 5118.0 4300.9 4318.3 4330.4 4332.0 4363.5 4501.4 4505.3 4509.0 4529.6 4544.8 4658.8 4770.9 4771.0 4772.0 4884.5 5084.5 5094.3 5102.8 5107.9 5141.0 4823.9 4825.7 4829.4 4843.1 4886.3 4740.0 4844.3 4845.6 5004.4 5121.5 5113.6 5115.4 5121.7 5125.6 5126.2 4909.4 4924.8 4927.2 4928.1 4960.4 4590.1 4760.5 4785.2 4878.3 4928.5 4826.3 4849.0 4854.0 4877.8 4898.6 4897.5 4970.6 4977.3 4995.3 5013.6 4615.7 4736.2 4737.8 4742.4 4846.1 01:12:00 INFO - 2015-12-17 01:12:00,780 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-12-17 01:12:00,780 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40528.76 Median:32687.51 stddev:64184.29 (196.4%) stddev-sans-first:64294.16 01:12:00 INFO - 2015-12-17 01:12:00,780 DEBUG : BROWSER_OUTPUT: Values: 553.8 559.5 560.2 560.6 567.5 26407.2 27025.3 33035.2 33170.3 33205.3 38886.2 39403.8 39425.8 39458.0 39473.4 6874.4 7845.1 8034.0 8042.2 8053.1 7019.9 7122.3 7126.4 7126.8 9816.1 9887.1 9958.5 9965.3 9966.8 9976.9 9834.4 9914.8 9922.2 9928.5 9964.0 7202.9 7435.9 7438.1 7439.1 10126.5 37173.4 37651.2 37699.8 37740.8 37807.2 2867.7 2917.0 2981.1 2988.5 3043.5 27169.7 28467.6 28596.4 28605.3 29215.1 3124.9 3148.5 3151.5 3168.0 3184.6 209790.0 210653.0 210854.0 211270.0 211762.0 54984.0 55183.0 55322.2 55324.0 55572.0 57657.0 58083.0 58187.0 58214.4 58297.0 14260.7 14857.9 14901.4 14923.3 14937.6 11358.3 11441.8 11446.7 11448.4 11461.4 18997.5 19004.6 19124.0 19124.8 19159.6 7207.8 7556.5 7563.5 7602.7 7618.0 845.7 900.8 965.2 1028.8 1032.0 26704.7 26762.5 26974.7 27143.3 27199.2 884.5 966.5 971.7 981.2 1071.9 12685.1 13076.9 13550.5 13551.4 13648.9 253678.0 255235.0 258664.0 258873.0 259242.0 46453.3 46877.3 46888.3 46901.5 46948.1 1124.6 1125.0 1204.9 1211.1 1239.9 25396.9 27482.2 29231.0 29391.3 29751.0 40297.6 40548.3 40581.6 40599.4 40616.2 199499.0 221463.0 223681.9 322527.0 335953.0 26943.6 27020.0 27040.7 27126.3 27447.5 36826.6 38921.8 39595.8 39844.8 40039.4 31562.4 32511.8 32561.7 33019.7 33300.0 32036.2 32372.5 32548.0 32728.5 32789.0 32256.5 32646.5 32899.3 32913.2 33139.5 28293.3 29292.6 30785.6 32883.5 33066.2 23365.2 23681.2 24025.6 25696.0 26200.5 01:12:00 INFO - 2015-12-17 01:12:00,780 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-12-17 01:12:00,780 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25568.00 Median:260399.82 stddev:78860.15 (30.3%) stddev-sans-first:79058.59 01:12:00 INFO - 2015-12-17 01:12:00,781 DEBUG : BROWSER_OUTPUT: Values: 325.4 333.2 333.9 335.9 338.0 12638.6 12871.4 14461.2 14942.5 15161.8 12626.4 15149.8 15170.8 15612.1 15631.9 4983.0 4996.8 5121.0 5135.5 5157.8 3452.3 3555.3 4899.2 5125.9 5143.3 5035.1 5076.0 5078.4 5080.9 5085.4 5027.5 5040.7 5084.3 5734.2 5742.1 5096.8 5100.8 5102.1 5104.3 5105.6 11284.2 11790.3 12235.4 12246.2 12257.2 1772.1 1790.7 1793.1 1854.7 1964.7 8741.6 9064.2 9127.5 9138.2 10537.9 1682.2 1754.9 1785.2 1804.2 1818.4 55570.7 56663.2 56894.0 58414.4 58438.7 9876.3 9987.4 9994.6 10028.0 10106.1 12668.2 12690.2 12697.2 12702.5 12711.7 7258.8 7268.6 7288.5 7327.6 7333.7 7075.0 7079.1 7102.3 7156.2 7156.4 4197.8 4201.5 4220.1 4255.7 4296.4 1519.6 1568.5 1691.4 1713.8 1737.1 378.3 382.9 851.2 866.2 970.3 9724.9 10058.8 10080.2 10082.7 10151.7 364.8 406.9 419.1 419.5 424.6 5395.2 5537.5 5616.6 5636.3 5649.1 473469.6 474412.0 479803.0 482916.0 495068.0 72621.0 76032.0 76406.6 76551.2 78693.6 1063.9 1074.6 1076.4 1100.1 1101.8 14683.2 14761.0 14836.6 15078.9 15247.6 33351.8 33380.0 33820.5 33994.3 34139.0 45127.8 45605.4 46869.0 47330.0 47399.5 8692.2 8868.5 8910.3 8913.2 8913.4 10145.3 10363.8 10415.3 10422.5 10548.9 9450.5 9466.0 9507.4 9511.5 9595.7 9608.8 9725.6 9758.1 9776.8 9891.9 7891.2 9696.0 9714.3 9807.0 9917.9 11367.5 11770.5 11833.8 13638.2 14238.7 9358.7 9491.0 9751.2 9762.3 14752.6 01:12:00 INFO - 2015-12-17 01:12:00,781 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-12-17 01:12:00,781 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5022.81 Median:6292.42 stddev:2608.31 (41.5%) stddev-sans-first:2599.99 01:12:00 INFO - 2015-12-17 01:12:00,782 DEBUG : BROWSER_OUTPUT: Values: 1223.8 1648.9 1701.8 1723.2 1731.8 6156.1 6726.8 7099.4 7106.5 7113.6 6905.0 6934.8 6988.1 6990.5 6997.7 2036.2 2060.8 2063.4 2064.7 2065.2 2013.6 2018.4 2049.8 2098.2 2109.7 2046.1 2120.0 2139.9 2154.9 2155.5 2100.6 2129.9 2130.2 2132.8 2133.3 2061.5 2096.2 2097.2 2099.4 2103.4 7211.4 7271.9 7295.4 7320.2 7322.3 4236.7 4307.4 4309.1 4309.8 4320.9 2728.4 2734.4 2767.1 2778.7 2803.4 877.4 1545.9 1554.2 1556.2 1575.6 9626.3 9785.0 9812.7 9825.4 9833.3 3819.6 3861.9 3870.0 3881.2 3939.7 7892.1 7898.6 7909.9 7911.5 7930.2 4214.0 4224.9 4227.6 4229.0 4235.2 3286.6 3418.9 3781.7 3901.2 3903.0 3278.5 3311.9 3345.1 3345.2 3352.9 969.8 980.1 983.4 989.6 991.1 885.2 895.7 934.6 1209.1 1212.8 6841.9 6924.3 6931.2 6950.6 6972.6 408.3 409.7 413.3 413.5 414.2 5484.0 5527.3 5536.6 5547.2 5547.6 8435.5 8438.5 8576.4 8589.4 8626.3 8502.6 8525.2 8568.9 8604.2 8609.8 6650.8 6811.4 6851.1 6906.9 6977.2 6904.3 6972.9 6993.9 6995.3 6999.2 7774.7 7913.1 7915.2 7995.6 8024.1 7584.4 7780.3 7826.0 7842.6 8194.0 5405.9 6070.4 6226.3 6310.0 6332.1 6904.8 6917.7 6963.0 6966.6 6972.4 6463.4 6623.2 6639.6 6639.8 6702.9 6274.8 6344.6 6426.3 6427.8 6507.2 6599.8 6622.9 6647.2 6651.7 6653.2 5771.0 6058.6 6114.3 6148.3 6150.0 5900.8 6214.8 6214.8 6232.1 6236.7 01:12:00 INFO - 2015-12-17 01:12:00,782 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-12-17 01:12:00,782 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4659.14 Median:5336.40 stddev:1361.96 (25.5%) stddev-sans-first:1325.74 01:12:00 INFO - 2015-12-17 01:12:00,782 DEBUG : BROWSER_OUTPUT: Values: 291.4 291.6 292.1 295.9 302.1 5274.6 5327.3 5348.3 5415.5 5464.6 5327.4 5334.5 5338.3 5340.3 5341.9 4161.6 4168.1 4168.4 4170.5 4176.0 4141.8 4170.8 4173.0 4178.8 4180.7 4039.3 4117.6 4138.9 4140.3 4145.4 4123.6 4125.0 4133.1 4133.7 4140.7 3622.3 3626.7 3629.6 3630.1 3637.6 5099.8 5129.9 5134.0 5137.3 5146.5 4703.9 4746.8 4748.5 4751.9 4752.4 5436.3 5580.4 5592.1 5592.9 5599.2 3959.1 3961.0 3964.6 3966.1 3972.1 5586.5 5789.3 5881.6 5888.6 5897.4 3937.9 4046.9 4057.5 4073.8 4084.8 4102.2 4123.5 4126.0 4128.4 4143.0 4434.0 4564.2 4609.2 4703.8 4722.9 5595.2 5602.2 5607.1 5608.6 5616.1 1437.8 1463.3 1464.1 1465.8 1466.9 979.7 988.7 994.3 1001.5 1005.2 4942.6 4943.7 4944.2 4952.3 4956.4 5811.0 5811.8 5813.6 5816.5 5817.9 4926.3 4933.0 4935.3 4937.5 4938.8 3058.3 3078.4 3101.4 3125.4 3131.3 5493.9 5495.7 5499.1 5502.8 5503.8 5935.0 5936.0 5940.7 5942.5 5944.0 5487.3 5487.5 5488.7 5491.1 5492.5 5606.6 5788.5 5812.8 5816.4 5818.3 5656.8 5669.0 5674.1 5674.3 5674.6 5506.8 5515.8 5519.2 5520.1 5520.4 3924.6 4006.3 4007.4 4021.3 4025.3 5583.7 5768.9 5792.9 5804.2 5805.4 5459.5 5612.6 5626.2 5645.7 5663.9 5654.8 5654.9 5658.5 5671.3 5674.3 5411.0 5510.6 5528.0 5547.2 5548.9 5712.2 5712.3 5715.5 5716.9 5718.9 5551.1 5562.1 5568.9 5578.6 5579.8 01:12:00 INFO - 2015-12-17 01:12:00,783 DEBUG : BROWSER_OUTPUT: 01:12:00 INFO - 2015-12-17 01:12:00,783 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11578.89 Median:22963.29 stddev:12440.96 (54.2%) stddev-sans-first:12448.80 01:12:00 INFO - 2015-12-17 01:12:00,783 DEBUG : BROWSER_OUTPUT: Values: 652.2 691.0 742.5 751.7 754.6 11776.1 11920.5 11957.7 11958.0 11976.2 11314.7 11623.0 11765.7 11770.2 11781.9 807.8 815.2 815.3 815.8 817.7 795.3 797.5 799.5 800.4 802.6 837.7 840.8 841.0 841.8 841.9 829.5 829.8 832.9 833.7 837.6 612.0 617.4 617.7 619.3 621.2 10834.4 10967.6 10970.7 10988.5 10999.9 9459.3 9740.0 9854.1 9979.9 10148.8 7921.6 8304.8 8424.0 8466.7 8482.5 3134.5 3221.7 3235.9 3237.0 3268.8 36444.0 37124.6 37225.6 37298.6 38274.4 9177.2 9224.7 9407.0 9491.1 9498.6 15180.7 15217.3 15228.5 15240.2 15250.9 6161.3 6287.1 6378.2 6443.5 6451.2 3063.1 3320.6 3393.4 3421.3 3488.1 2560.9 2583.3 2584.1 2586.4 2591.4 461.5 470.0 470.5 475.4 476.1 573.9 607.4 615.0 622.8 634.2 7818.1 8065.5 8125.3 8132.3 8358.2 529.4 532.0 532.4 562.7 622.8 3774.2 3903.1 4069.9 4088.4 4165.8 41760.8 42090.0 42213.8 42271.8 42361.4 38021.8 38585.0 38680.2 38837.2 38979.0 31655.7 38157.4 39081.8 39919.6 40101.4 8029.4 8195.1 8341.5 8342.7 8386.3 31132.5 31287.0 31986.4 32009.8 32127.8 31644.0 37044.0 39268.0 39376.0 39464.4 10081.3 10085.3 10094.9 10181.8 10246.8 11172.2 11354.9 11438.4 11590.9 11779.9 10385.0 10752.7 10911.7 11157.2 11273.9 10206.5 10224.1 10408.8 10637.6 10656.5 10443.9 10850.5 10857.9 10878.2 10963.6 9480.1 9493.2 9507.9 9781.0 9930.1 8985.2 9048.9 9277.4 9366.5 9460.8 01:12:00 INFO - 2015-12-17 01:12:00,783 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:12:00 INFO - 2015-12-17 01:12:00,783 DEBUG : BROWSER_OUTPUT: 01:12:01 INFO - 2015-12-17 01:12:01,545 INFO : Browser exited with error code: 0 01:12:01 INFO - 2015-12-17 01:12:01,566 INFO : Completed test dromaeo_css (00:18:36) 01:12:01 INFO - 2015-12-17 01:12:01,566 INFO : Starting test kraken 01:12:01 INFO - 2015-12-17 01:12:01,566 DEBUG : operating with platform_type : linux_ 01:12:01 INFO - 2015-12-17 01:12:01,567 INFO : Initialising browser for kraken test... 01:12:01 INFO - 2015-12-17 01:12:01,573 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzNDZ8c/profile http://localhost:43098/getInfo.html 01:12:05 INFO - 2015-12-17 01:12:05,416 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:12:05 INFO - 2015-12-17 01:12:05,416 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:12:05 INFO - 2015-12-17 01:12:05,416 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:12:05 INFO - 2015-12-17 01:12:05,416 DEBUG : BROWSER_OUTPUT: __metrics 01:12:05 INFO - 2015-12-17 01:12:05,539 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:12:05 INFO - 2015-12-17 01:12:05,615 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] 01:12:06 INFO - 2015-12-17 01:12:06,585 INFO : Browser initialized. 01:12:06 INFO - 2015-12-17 01:12:06,585 INFO : Running cycle 1/1 for kraken test... 01:12:06 INFO - 2015-12-17 01:12:06,585 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzNDZ8c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:12:18 INFO - 2015-12-17 01:12:18,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 142487552 01:12:18 INFO - 2015-12-17 01:12:18,629 DEBUG : BROWSER_OUTPUT: 01:12:21 INFO - 2015-12-17 01:12:21,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43098/tests/kraken/driver.html?testName=audio-beat-detection) 01:12:21 INFO - 2015-12-17 01:12:21,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 176975872 01:12:21 INFO - 2015-12-17 01:12:21,803 DEBUG : BROWSER_OUTPUT: 01:12:24 INFO - 2015-12-17 01:12:24,550 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43098/tests/kraken/driver.html?testName=audio-dft) 01:12:25 INFO - 2015-12-17 01:12:25,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 165728256 01:12:25 INFO - 2015-12-17 01:12:25,131 DEBUG : BROWSER_OUTPUT: 01:12:28 INFO - 2015-12-17 01:12:28,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43098/tests/kraken/driver.html?testName=audio-fft) 01:12:28 INFO - 2015-12-17 01:12:28,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 152047616 01:12:28 INFO - 2015-12-17 01:12:28,709 DEBUG : BROWSER_OUTPUT: 01:12:30 INFO - 2015-12-17 01:12:30,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43098/tests/kraken/driver.html?testName=audio-oscillator) 01:12:31 INFO - 2015-12-17 01:12:31,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 155619328 01:12:31 INFO - 2015-12-17 01:12:31,319 DEBUG : BROWSER_OUTPUT: 01:12:33 INFO - 2015-12-17 01:12:33,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43098/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:12:34 INFO - 2015-12-17 01:12:34,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 157880320 01:12:34 INFO - 2015-12-17 01:12:34,139 DEBUG : BROWSER_OUTPUT: 01:12:37 INFO - 2015-12-17 01:12:37,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43098/tests/kraken/driver.html?testName=imaging-darkroom) 01:12:37 INFO - 2015-12-17 01:12:37,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 156057600 01:12:37 INFO - 2015-12-17 01:12:37,713 DEBUG : BROWSER_OUTPUT: 01:12:41 INFO - 2015-12-17 01:12:41,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43098/tests/kraken/driver.html?testName=imaging-desaturate) 01:12:41 INFO - 2015-12-17 01:12:41,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 158068736 01:12:41 INFO - 2015-12-17 01:12:41,694 DEBUG : BROWSER_OUTPUT: 01:12:44 INFO - 2015-12-17 01:12:44,538 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43098/tests/kraken/driver.html?testName=json-parse-financial) 01:12:45 INFO - 2015-12-17 01:12:45,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 157650944 01:12:45 INFO - 2015-12-17 01:12:45,120 DEBUG : BROWSER_OUTPUT: 01:12:46 INFO - 2015-12-17 01:12:46,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43098/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:12:47 INFO - 2015-12-17 01:12:47,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 163659776 01:12:47 INFO - 2015-12-17 01:12:47,486 DEBUG : BROWSER_OUTPUT: 01:12:49 INFO - 2015-12-17 01:12:49,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43098/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:12:49 INFO - 2015-12-17 01:12:49,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 164802560 01:12:49 INFO - 2015-12-17 01:12:49,980 DEBUG : BROWSER_OUTPUT: 01:12:52 INFO - 2015-12-17 01:12:52,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43098/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:12:52 INFO - 2015-12-17 01:12:52,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 176476160 01:12:52 INFO - 2015-12-17 01:12:52,681 DEBUG : BROWSER_OUTPUT: 01:12:55 INFO - 2015-12-17 01:12:55,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:12:55 INFO - 2015-12-17 01:12:55,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 181534720 01:12:55 INFO - 2015-12-17 01:12:55,815 DEBUG : BROWSER_OUTPUT: 01:12:58 INFO - 2015-12-17 01:12:58,422 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:12:59 INFO - 2015-12-17 01:12:59,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 180269056 01:12:59 INFO - 2015-12-17 01:12:59,004 DEBUG : BROWSER_OUTPUT: 01:13:00 INFO - 2015-12-17 01:13:00,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43098/tests/kraken/driver.html?testName=ai-astar) 01:13:01 INFO - 2015-12-17 01:13:01,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 239517696 01:13:01 INFO - 2015-12-17 01:13:01,011 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,015 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:13:01 INFO - 2015-12-17 01:13:01,015 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:13:01 INFO - 2015-12-17 01:13:01,015 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:13:01 INFO - 2015-12-17 01:13:01,015 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:13:01 INFO - 2015-12-17 01:13:01,015 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;117;109;112;113;112;102;112;114;113 01:13:01 INFO - 2015-12-17 01:13:01,016 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;133;155;165;130;153;162;132;171;129 01:13:01 INFO - 2015-12-17 01:13:01,016 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;160;160;162;160;161;162;161;161 01:13:01 INFO - 2015-12-17 01:13:01,016 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;75;85;94;72;74;72;101;91;72 01:13:01 INFO - 2015-12-17 01:13:01,016 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;96;95;96;133;95;95;130 01:13:01 INFO - 2015-12-17 01:13:01,016 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;110;110;109;109;109 01:13:01 INFO - 2015-12-17 01:13:01,016 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;147;147;146;146;146;148;146 01:13:01 INFO - 2015-12-17 01:13:01,016 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;74;72;72;74;73;71;83;70;71 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;69;69;69;68;69;69;69;69 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;84;83;83;84;83;84;85;85 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;126;124;123;121;131;128;126;120;131 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;149;151;145;149;140;148;146;155;135 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;71;69;68;70;70;69;68;70;69 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1011 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: __startTimestamp1450343581013__endTimestamp 01:13:01 INFO - 2015-12-17 01:13:01,017 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.95 (3.5%) stddev-sans-first:4.16 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: Values: 113.0 117.0 109.0 112.0 113.0 112.0 102.0 112.0 114.0 113.0 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.80 Median:156.50 stddev:16.15 (10.3%) stddev-sans-first:16.78 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: Values: 158.0 133.0 155.0 165.0 130.0 153.0 162.0 132.0 171.0 129.0 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 160.0 160.0 162.0 160.0 161.0 162.0 161.0 161.0 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:74.50 stddev:10.94 (14.7%) stddev-sans-first:11.22 01:13:01 INFO - 2015-12-17 01:13:01,021 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 85.0 94.0 72.0 74.0 72.0 101.0 91.0 72.0 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:17.43 (18.3%) stddev-sans-first:18.02 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 96.0 95.0 96.0 133.0 95.0 95.0 130.0 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 148.0 146.0 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,022 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.30 Median:73.00 stddev:3.65 (5.0%) stddev-sans-first:3.87 01:13:01 INFO - 2015-12-17 01:13:01,023 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 72.0 72.0 74.0 73.0 71.0 83.0 70.0 71.0 01:13:01 INFO - 2015-12-17 01:13:01,023 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,023 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 01:13:01 INFO - 2015-12-17 01:13:01,023 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 69.0 69.0 69.0 68.0 69.0 69.0 69.0 69.0 01:13:01 INFO - 2015-12-17 01:13:01,023 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,023 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 01:13:01 INFO - 2015-12-17 01:13:01,023 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 84.0 83.0 83.0 84.0 83.0 84.0 85.0 85.0 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.90 Median:127.00 stddev:3.90 (3.1%) stddev-sans-first:3.97 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: Values: 129.0 126.0 124.0 123.0 121.0 131.0 128.0 126.0 120.0 131.0 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.80 Median:148.50 stddev:5.98 (4.0%) stddev-sans-first:5.96 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: Values: 140.0 149.0 151.0 145.0 149.0 140.0 148.0 146.0 155.0 135.0 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 69.0 68.0 70.0 70.0 69.0 68.0 70.0 69.0 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:13:01 INFO - 2015-12-17 01:13:01,024 DEBUG : BROWSER_OUTPUT: 01:13:01 INFO - 2015-12-17 01:13:01,877 INFO : Browser exited with error code: 0 01:13:01 INFO - 2015-12-17 01:13:01,930 INFO : Completed test kraken (00:01:00) 01:13:01 INFO - 2015-12-17 01:13:01,930 INFO : Starting test v8_7 01:13:01 INFO - 2015-12-17 01:13:01,931 DEBUG : operating with platform_type : linux_ 01:13:01 INFO - 2015-12-17 01:13:01,931 INFO : Initialising browser for v8_7 test... 01:13:01 INFO - 2015-12-17 01:13:01,937 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0VEI5c/profile http://localhost:43098/getInfo.html 01:13:06 INFO - 2015-12-17 01:13:06,113 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:13:06 INFO - 2015-12-17 01:13:06,113 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:13:06 INFO - 2015-12-17 01:13:06,113 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:13:06 INFO - 2015-12-17 01:13:06,113 DEBUG : BROWSER_OUTPUT: __metrics 01:13:06 INFO - 2015-12-17 01:13:06,215 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:13:06 INFO - 2015-12-17 01:13:06,276 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] 01:13:07 INFO - 2015-12-17 01:13:07,206 INFO : Browser initialized. 01:13:07 INFO - 2015-12-17 01:13:07,207 INFO : Running cycle 1/1 for v8_7 test... 01:13:07 INFO - 2015-12-17 01:13:07,207 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0VEI5c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:13:19 INFO - 2015-12-17 01:13:19,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 143360000 01:13:19 INFO - 2015-12-17 01:13:19,214 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43098/tests/v8_7/run.html (next: http://localhost:43098/tests/v8_7/run.html) 01:13:40 INFO - 2015-12-17 01:13:40,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 452665344 01:13:40 INFO - 2015-12-17 01:13:40,922 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,922 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:13:40 INFO - 2015-12-17 01:13:40,922 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:13:40 INFO - 2015-12-17 01:13:40,922 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:13:40 INFO - 2015-12-17 01:13:40,922 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |0;Richards;166.19577862722286 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.28912071535024 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.61081385525205 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5148.717948717948 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |5;Earley;785.5459544383347 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |6;Boyer;12240.963855421687 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |7;RegExp;29200 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |8;Splay;603.5003017501509 01:13:40 INFO - 2015-12-17 01:13:40,923 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: __startTimestamp1450343620921__endTimestamp 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: Values: 166.2 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.29 Median:186.29 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: Values: 186.3 01:13:40 INFO - 2015-12-17 01:13:40,924 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,925 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.61 Median:281.61 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,925 DEBUG : BROWSER_OUTPUT: Values: 281.6 01:13:40 INFO - 2015-12-17 01:13:40,925 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,925 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,925 DEBUG : BROWSER_OUTPUT: Values: 5148.7 01:13:40 INFO - 2015-12-17 01:13:40,925 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,926 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,926 DEBUG : BROWSER_OUTPUT: Values: 1972.4 01:13:40 INFO - 2015-12-17 01:13:40,926 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,926 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:785.55 Median:785.55 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,926 DEBUG : BROWSER_OUTPUT: Values: 785.5 01:13:40 INFO - 2015-12-17 01:13:40,926 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,927 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12240.96 Median:12240.96 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,927 DEBUG : BROWSER_OUTPUT: Values: 12241.0 01:13:40 INFO - 2015-12-17 01:13:40,927 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,927 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29200.00 Median:29200.00 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,927 DEBUG : BROWSER_OUTPUT: Values: 29200.0 01:13:40 INFO - 2015-12-17 01:13:40,927 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,927 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.50 Median:603.50 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,928 DEBUG : BROWSER_OUTPUT: Values: 603.5 01:13:40 INFO - 2015-12-17 01:13:40,928 DEBUG : BROWSER_OUTPUT: 01:13:40 INFO - 2015-12-17 01:13:40,928 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 01:13:40 INFO - 2015-12-17 01:13:40,928 DEBUG : BROWSER_OUTPUT: Values: 4840.6 01:13:40 INFO - 2015-12-17 01:13:40,928 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:13:40 INFO - 2015-12-17 01:13:40,928 DEBUG : BROWSER_OUTPUT: 01:13:41 INFO - 2015-12-17 01:13:41,790 INFO : Browser exited with error code: 0 01:13:41 INFO - 2015-12-17 01:13:41,807 INFO : Completed test v8_7 (00:00:39) 01:13:41 INFO - 2015-12-17 01:13:41,877 INFO : Completed test suite (00:20:17) 01:13:41 INFO - 2015-12-17 01:13:41,877 DEBUG : Working with test: dromaeo_css 01:13:41 INFO - 2015-12-17 01:13:41,877 DEBUG : Generating results file: dromaeo_css 01:13:41 INFO - 2015-12-17 01:13:41,878 DEBUG : Working with test: kraken 01:13:41 INFO - 2015-12-17 01:13:41,878 DEBUG : Generating results file: kraken 01:13:41 INFO - 2015-12-17 01:13:41,879 INFO : javascript benchmark 01:13:41 INFO - 2015-12-17 01:13:41,879 DEBUG : Working with test: v8_7 01:13:41 INFO - 2015-12-17 01:13:41,879 DEBUG : Generating results file: v8_7 01:13:41 INFO - 2015-12-17 01:13:41,879 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:41 INFO - 2015-12-17 01:13:41,941 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 01:13:41 INFO - 2015-12-17 01:13:41,941 DEBUG : process_Request line: dromaeo_css 6202.73 graph.html#tests=[[72,203,35]] 01:13:41 INFO - 2015-12-17 01:13:41,941 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:41 INFO - 2015-12-17 01:13:41,981 DEBUG : process_Request line: kraken 1526.40 graph.html#tests=[[232,203,35]] 01:13:41 INFO - 2015-12-17 01:13:41,981 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:13:42 INFO - 2015-12-17 01:13:42,019 DEBUG : process_Request line: v8_7 19652.16 graph.html#tests=[[230,203,35]] 01:13:42 INFO - 2015-12-17 01:13:42,020 INFO : javascript benchmark 01:13:42 INFO - 2015-12-17 01:13:42,024 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2594.6497222874914, 2710.620513128162, 2715.321169707573, 2716.9320766980823, 2733.4533093381324, 4500.864974050775, 4630.421197350332, 4719.716816990978, 4744.478107408187, 4758.809647614095, 4655.627549796017, 4712.90574188516, 4773.832915847937, 4778.976105119478, 4780.617550595953, 4304.935425968613, 4340.045190058182, 4352.630026447756, 4441.222786012451, 4479.574440428154, 4210.431591735107, 4402.339649052636, 4434.933475997863, 4474.418325617665, 4538.205813982539, 4222.2188895054205, 4288.463942007249, 4289.099289149282, 4300.096979634281, 4314.482262128533, 4375.387445757597, 4391.538888416702, 4394.802233899451, 4416.381706561084, 4423.447069116361, 4156.896077598054, 4249.596288352602, 4357.542458041891, 4384.123175364908, 4442.178197033559, 4586.931196032062, 4634.791434385461, 4702.0, 4725.362076119714, 4792.400949881265, 5076.720780357079, 5077.593792496591, 5088.949110508885, 5091.134507133796, 5117.027764724728, 4911.238757992481, 5023.0, 5105.566026887719, 5107.361579802525, 5107.642465027412, 4645.442546894395, 4666.626669866437, 4711.0, 4726.338312636233, 4768.57082862544, 5181.145111056709, 5182.870428239325, 5184.326037615161, 5227.555657769056, 5235.947640523622, 4743.66794324394, 4831.710097394168, 4958.776855041532, 4968.403791545038, 4984.152694042022, 4982.90034199314, 5024.221245706921, 5126.564242039469, 5130.486951304914, 5154.896902061938, 5007.4491805901325, 5022.196448568212, 5031.698098114125, 5046.394432668103, 5076.36545431821, 4805.1590971579835, 4932.136876046678, 4995.325631039836, 4999.450060493343, 5004.724740139254, 4093.7134400592267, 4124.1957818225155, 4149.751014939114, 4169.45797046382, 4209.936850947238, 3696.8336424860945, 3718.460823180678, 3719.8698045568276, 3737.1404576947452, 3747.38168202249, 4180.519240287406, 4271.081717430768, 4370.147821174904, 4420.955790442119, 4452.777361131995, 4998.550130488274, 5034.949650503448, 5070.7464626768515, 5109.846704598868, 5118.0, 4300.89247768802, 4318.3090705486975, 4330.35044743291, 4332.0469496710675, 4363.47638283408, 4501.392312037899, 4505.256632655575, 4508.954910450919, 4529.569690879362, 4544.84093056748, 4658.767061646904, 4770.928436073531, 4771.021940502258, 4771.976140119277, 4884.535969082932, 5084.466131056186, 5094.337736094284, 5102.795888164432, 5107.87230319245, 5140.997505486394, 4823.879403014953, 4825.734584597881, 4829.396325459317, 4843.07981483517, 4886.340344053508, 4739.976300118477, 4844.32179494864, 4845.636577256791, 5004.424491183415, 5121.487851214849, 5113.565346945403, 5115.437301896863, 5121.74391280442, 5125.589952803842, 5126.154184559655, 4909.410870695397, 4924.82763103304, 4927.211646136601, 4928.11293967075, 4960.404751429852, 4590.127875703605, 4760.452547957029, 4785.162596545661, 4878.341423907727, 4928.457869634266, 4826.348442960296, 4848.981713839992, 4854.0, 4877.756112194305, 4898.583620392306, 4897.485763994871, 4970.62720295972, 4977.253411988231, 4995.2507123930245, 5013.623978201576, 4615.676902616785, 4736.17117004516, 4737.810487580458, 4742.359781429601, 4846.103470857903], "unit": "score", "name": "dojo.html", "value": 4629.0869936949175}, {"lowerIsBetter": false, "replicates": [553.8061678412555, 559.5271995164086, 560.1597603594608, 560.5683623609821, 567.5176100314735, 26407.20778376647, 27025.324366890836, 33035.17412064697, 33170.33659326812, 33205.339733013374, 38886.22227555447, 39403.80298098513, 39425.80287098567, 39458.0, 39473.40789888154, 6874.415674667659, 7845.13703492614, 8033.95983020087, 8042.2359875812, 8053.114157442706, 7019.929800702004, 7122.323379278961, 7126.429885609165, 7126.821829454253, 9816.116549510543, 9887.11016008559, 9958.502074896262, 9965.252606054539, 9966.800663986753, 9976.850347244797, 9834.409935403863, 9914.752131196705, 9922.156616687555, 9928.50357482123, 9964.0, 7202.855942881113, 7435.85128297431, 7438.070241219848, 7439.107307123126, 10126.54430550627, 37173.442398364044, 37651.24697506035, 37699.81150094232, 37740.81129594362, 37807.243855122746, 2867.7419032286984, 2916.985415072911, 2981.1354707134906, 2988.5068963620975, 3043.46739320618, 27169.728302716918, 28467.57298640522, 28596.428071438455, 28605.28486787847, 29215.123546293646, 3124.875004999797, 3148.496240601493, 3151.4642510773224, 3167.9683203168133, 3184.586003819512, 209790.0, 210653.0, 210854.0, 211270.0, 211761.99999999846, 54984.0, 55183.0, 55322.17016744752, 55324.0, 55572.0, 57657.0, 58083.0, 58187.0, 58214.417855821746, 58297.0, 14260.714785704227, 14857.851421485862, 14901.403943842342, 14923.328450219766, 14937.551873443814, 11358.26171298863, 11441.771164576661, 11446.656600302003, 11448.370339631234, 11461.426928653535, 18997.525061873286, 19004.61990760177, 19124.0, 19124.80875191258, 19159.61680766377, 7207.783766487014, 7556.508826926232, 7563.457095668345, 7602.695892164252, 7617.961910190525, 845.691322667222, 900.8378491871526, 965.1940629574384, 1028.7633844215723, 1031.973186679259, 26704.732952670613, 26762.464750704876, 26974.730252697223, 27143.32141696434, 27199.1840244793, 884.4958373727043, 966.5022513405602, 971.7376308396694, 981.1562056631292, 1071.8767341755643, 12685.14357053683, 13076.934615327053, 13550.45798168082, 13551.39018744159, 13648.93175534116, 253678.0, 255235.0, 258664.0, 258873.0, 259242.0, 46453.30320045202, 46877.29684054742, 46888.29667554989, 46901.5309846904, 46948.06103877904, 1124.5726623882872, 1125.0324720740157, 1204.8975837053774, 1211.1340391619858, 1239.9380030998595, 25396.873015634803, 27482.17553473399, 29231.0, 29391.26521836971, 29751.0, 40297.59702402938, 40548.33694125096, 40581.594184058966, 40599.39100913548, 40616.187676246904, 199499.0, 221463.0, 223681.88159059102, 322527.0, 335953.0, 26943.595846062715, 27020.0, 27040.72959270382, 27126.321841954108, 27447.45105097847, 36826.63173368232, 38921.80539097286, 39595.80202098971, 39844.80077599709, 40039.39940900947, 31562.36875262528, 32511.83744081359, 32561.674383256814, 33019.66980330166, 33300.0, 32036.19909502281, 32372.514412283363, 32548.0, 32728.50907236441, 32789.0, 32256.516152258206, 32646.51030234596, 32899.34201316008, 32913.177170570925, 33139.50290745689, 28293.292667683472, 29292.560611590416, 30785.64057786961, 32883.50674739833, 33066.173345665586, 23365.182218622267, 23681.17115900935, 24025.639615405435, 25696.0, 26200.475990479703], "unit": "score", "name": "ext.html", "value": 17012.45186422543}, {"lowerIsBetter": false, "replicates": [325.4418671977559, 333.23522515826176, 333.9332133573286, 335.89561397842516, 337.9526866238725, 12638.557650482235, 12871.420786064626, 14461.20463374514, 14942.477013304537, 15161.848381516182, 12626.431810568523, 15149.77275340868, 15170.772438413433, 15612.141332226724, 15631.92184039081, 4983.028309479653, 4996.825111121102, 5120.974395128019, 5135.486451354872, 5157.767900444489, 3452.2577645806145, 3555.342261681584, 4899.191633380488, 5125.871853203663, 5143.305653736735, 5035.118854200518, 5076.03555324489, 5078.365204349457, 5080.949190508085, 5085.389753229618, 5027.547520723134, 5040.697558146505, 5084.262781896623, 5734.225879506255, 5742.081266997302, 5096.847094587169, 5100.795968161269, 5102.081625307444, 5104.285400043959, 5105.617078719111, 11284.210105292634, 11790.292582445081, 12235.388230588524, 12246.203996740183, 12257.203281786655, 1772.1139430284857, 1790.713485842259, 1793.1213705284447, 1854.6568884756364, 1964.6758284882976, 8741.562921853945, 9064.184223419858, 9127.5436228189, 9138.223251023672, 10537.9473102634, 1682.2093616000461, 1754.9385771497937, 1785.2234278088943, 1804.2422182683174, 1818.3544841581313, 55570.72214638942, 56663.15005274924, 56894.0, 58414.41585584175, 58438.70780646112, 9876.308658393988, 9987.350822196535, 9994.600215991424, 10027.997200280059, 10106.090451859222, 12668.176568523017, 12690.238585684889, 12697.238165710087, 12702.491900323883, 12711.682207944876, 7258.818529536698, 7268.636568171571, 7288.453365997571, 7327.596982166032, 7333.669984850694, 7075.0, 7079.079719636415, 7102.254263302382, 7156.177039640404, 7156.355927966508, 4197.811098500575, 4201.516825565038, 4220.092680073799, 4255.680823938155, 4296.398504209413, 1519.5821149183841, 1568.5372815019596, 1691.4333698210992, 1713.8260291700226, 1737.114071823354, 378.3228021840929, 382.8526017483289, 851.2253848997383, 866.2463656618781, 970.2674480767117, 9724.873329802322, 10058.849117263248, 10080.193584513221, 10082.747931301776, 10151.7462063449, 364.79753736675866, 406.8982754311422, 419.130304617919, 419.53431690823163, 424.60299619855533, 5395.190721391823, 5537.501624853782, 5616.550675945996, 5636.323641163005, 5649.096144616841, 473469.63265184144, 474412.0, 479803.0, 482916.0, 495068.0, 72621.0, 76032.0, 76406.6179669098, 76551.23448765441, 78693.60653196697, 1063.9202059845543, 1074.5916551710457, 1076.3649446826566, 1100.1199040767353, 1101.7961677089604, 14683.19242441676, 14761.0, 14836.554903352917, 15078.924605376902, 15247.618809529851, 33351.83268585588, 33380.0, 33820.492692609136, 33994.320113598085, 34139.0, 45127.7743611293, 45605.439456054126, 46869.0, 47330.0, 47399.52600473951, 8692.217700406994, 8868.512231827312, 8910.331725120512, 8913.153250441197, 8913.420627659441, 10145.34055286404, 10363.75634923814, 10415.323004004715, 10422.478876056319, 10548.947255263674, 9450.527473626154, 9466.0, 9507.429554226768, 9511.476868772284, 9595.664151754656, 9608.807823843345, 9725.562349694423, 9758.121769040821, 9776.755581110529, 9891.851622225817, 7891.210878912063, 9695.951520242354, 9714.3199976001, 9807.0, 9917.900820991987, 11367.54529818798, 11770.52917883275, 11833.822492662444, 13638.249896255802, 14238.715225695221, 9358.719238422858, 9490.952545237229, 9751.171150452292, 9762.316637835283, 14752.55742327732], "unit": "score", "name": "jquery.html", "value": 7501.7179156611455}, {"lowerIsBetter": false, "replicates": [1223.7980733179027, 1648.8763342749294, 1701.8042925063614, 1723.1556537296724, 1731.7662115614396, 6156.138140660306, 6726.831829204266, 7099.361057504823, 7106.467014973872, 7113.644317784103, 6904.965475172629, 6934.757283495079, 6988.126484189476, 6990.545614535052, 6997.685104170312, 2036.2364113457454, 2060.7836177201402, 2063.411927600634, 2064.6593312103487, 2065.1532871522677, 2013.5872146210065, 2018.3541266794632, 2049.80526849949, 2098.213170061227, 2109.662454007359, 2046.0690385874466, 2119.9718136703686, 2139.882306473143, 2154.9030293636824, 2155.4503601581655, 2100.5693832764246, 2129.8935053247274, 2130.2011745595323, 2132.7973842485017, 2133.296012315932, 2061.4537147655883, 2096.1615353858424, 2097.2345094040716, 2099.391176558796, 2103.379503046605, 7211.387032102225, 7271.927280727231, 7295.416366690705, 7320.194778574352, 7322.304381083789, 4236.661067114624, 4307.418498502693, 4309.052008558144, 4309.762963037032, 4320.9135817283795, 2728.386113124551, 2734.357426004887, 2767.059199872033, 2778.749912507864, 2803.4393121375806, 877.4472082587993, 1545.8995165314332, 1554.2384231726485, 1556.2218890554723, 1575.6139745762248, 9626.278029147772, 9785.0, 9812.705618831447, 9825.361351512129, 9833.26250531206, 3819.579846216914, 3861.8607510784386, 3869.96130038696, 3881.204353107606, 3939.6651284641125, 7892.131865494791, 7898.60506974649, 7909.920900791033, 7911.5253084815095, 7930.206979302024, 4214.0, 4224.936625950613, 4227.556106608823, 4228.9788551057045, 4235.174141042528, 3286.622038465607, 3418.9145271368416, 3781.716371272166, 3901.239258344652, 3903.0437542802197, 3278.49183376577, 3311.8840840570947, 3345.063382252973, 3345.247319353126, 3352.8826491072696, 969.8351280282369, 980.07872599756, 983.4246965525248, 989.5744829723288, 991.137710192123, 885.2165833237631, 895.6596493332622, 934.5887809363858, 1209.0992210803008, 1212.8120141378101, 6841.93158068413, 6924.307569243036, 6931.1682598088555, 6950.617716025566, 6972.616506092112, 408.2549347440873, 409.6845429019698, 413.3304047443101, 413.52857742173944, 414.22126402363364, 5484.040292948718, 5527.2538207342295, 5536.640118392292, 5547.223388725582, 5547.55619550435, 8435.451695639886, 8438.451500652438, 8576.44253123545, 8589.398742087993, 8626.266767324722, 8502.574871256413, 8525.232729054414, 8568.914310856937, 8604.225619694258, 8609.827803443895, 6650.83372915681, 6811.352921472353, 6851.143607049119, 6906.896396554056, 6977.232504424509, 6904.27505111956, 6972.860542789217, 6993.930060699531, 6995.265497122728, 6999.230084690578, 7774.650140743567, 7913.129555748978, 7915.208479152038, 7995.600219988861, 8024.077231118263, 7584.4311676625575, 7780.299773020455, 7826.0, 7842.568658723825, 8194.0, 5405.918911216414, 6070.423309785563, 6226.346233645402, 6310.021946598285, 6332.050192471166, 6904.758333458506, 6917.723291068301, 6963.025176475398, 6966.616836074065, 6972.372486476242, 6463.418292353711, 6623.205215374186, 6639.601623902581, 6639.800805975829, 6702.865942681216, 6274.811755647338, 6344.555881088464, 6426.260979987362, 6427.807165785034, 6507.186601674791, 6599.835004124935, 6622.867542649216, 6647.202335719745, 6651.700673469609, 6653.234877989094, 5770.971145144247, 6058.606190597597, 6114.327423983447, 6148.292946311231, 6150.0, 5900.822975310747, 6214.751409943552, 6214.8135555933395, 6232.065190221503, 6236.656983865931], "unit": "score", "name": "mootools.html", "value": 4070.2313117622975}, {"lowerIsBetter": false, "replicates": [291.37790816606554, 291.64128122409437, 292.0755807868098, 295.8565095928475, 302.05306364547135, 5274.55166310864, 5327.254184414185, 5348.277982472365, 5415.456594870463, 5464.590155738316, 5327.387350454689, 5334.546563542103, 5338.252644629755, 5340.279062326585, 5341.919871201935, 4161.646260067891, 4168.124693814288, 4168.374743788441, 4170.4578404807335, 4175.979120104395, 4141.792910354486, 4170.812313445887, 4172.958270417303, 4178.791060446981, 4180.686448516373, 4039.313316736162, 4117.608827161415, 4138.896527586804, 4140.254754144253, 4145.419641250227, 4123.587641235852, 4124.979375103106, 4133.111381053073, 4133.6693064554765, 4140.68944829136, 3622.3117607654463, 3626.7279954003293, 3629.6007439181667, 3630.09247688078, 3637.636236376368, 5099.821506247264, 5129.9230511542355, 5133.974330128362, 5137.306463627438, 5146.485351464861, 4703.905921881577, 4746.833860814855, 4748.501407352247, 4751.857444276678, 4752.405949256343, 5436.293281873371, 5580.38615752271, 5592.105263157916, 5592.86017849553, 5599.188117722907, 3959.089409435846, 3961.0493481564504, 3964.5837187095226, 3966.147278335172, 3972.086420123359, 5586.525145362649, 5789.2763404574425, 5881.558883083743, 5888.617239879394, 5897.380775018604, 3937.901552461154, 4046.9392959105635, 4057.4522439470884, 4073.837046518165, 4084.7957602119777, 4102.220578090153, 4123.525794533607, 4126.0, 4128.3601041838565, 4142.958570414317, 4434.0, 4564.246899261651, 4609.216433206363, 4703.7883295251795, 4722.881927951828, 5595.188697638901, 5602.159676048625, 5607.102863541813, 5608.579356548275, 5616.1014237721765, 1437.755581551139, 1463.2829913342598, 1464.0703153497607, 1465.7728052151933, 1466.933987970544, 979.7341981120544, 988.6885631026204, 994.2791476179711, 1001.4892404873567, 1005.1757558801859, 4942.555170034714, 4943.6786608871025, 4944.159492886218, 4952.257161425815, 4956.405231372259, 5811.041178205549, 5811.767529298781, 5813.563982701315, 5816.5055970243, 5817.912731309034, 4926.285688575136, 4933.0, 4935.333729946411, 4937.481564435682, 4938.777755000961, 3058.270175195913, 3078.3843231353817, 3101.3952279305317, 3125.3749250150063, 3131.3424180921807, 5493.945060549343, 5495.697736624444, 5499.120140777536, 5502.8349149525575, 5503.752331145108, 5934.970325148347, 5935.970320148372, 5940.70296485174, 5942.465178133989, 5944.019236825875, 5487.259220005249, 5487.506124448819, 5488.725563721798, 5491.066518691752, 5492.450754924475, 5606.551475882001, 5788.479036886701, 5812.796552120655, 5816.360200377871, 5818.301803783404, 5656.830295091154, 5668.971655141698, 5674.148877668383, 5674.319081710221, 5674.631148975303, 5506.779728810803, 5515.779368825202, 5519.227308176778, 5520.1167813149705, 5520.365158006881, 3924.6271604197555, 4006.318925782682, 4007.3988901663815, 4021.276170289259, 4025.275450418953, 5583.664980101207, 5768.94231057684, 5792.913106303493, 5804.24544809189, 5805.448482394166, 5459.508644222039, 5612.550995920398, 5626.240457538343, 5645.745941432728, 5663.886722265449, 5654.802081927113, 5654.886902262014, 5658.462446067617, 5671.347795003462, 5674.347450043298, 5411.0, 5510.586705996986, 5528.0, 5547.223388725501, 5548.916766248591, 5712.228849105484, 5712.257406537124, 5715.485606295453, 5716.9428305718075, 5718.914216286842, 5551.084071128219, 5562.137868630369, 5568.91646625309, 5578.609497335147, 5579.77680892776], "unit": "score", "name": "prototype.html", "value": 4218.72948951077}, {"lowerIsBetter": false, "replicates": [652.1782553981983, 691.0222035819315, 742.4913933955238, 751.654239050037, 754.6000619671572, 11776.11679124066, 11920.523179072838, 11957.701057473567, 11958.0, 11976.22154559953, 11314.717132071682, 11623.01204397625, 11765.705857353549, 11770.234934729237, 11781.941090294536, 807.7697856110995, 815.1725998111921, 815.3110621524802, 815.7960509872532, 817.6606708216083, 795.32397462157, 797.4975765267873, 799.4923223752901, 800.3997002248313, 802.5826570183501, 837.7068026190815, 840.7771940435789, 840.9537475438848, 841.8105926166625, 841.9158084191594, 829.4525613095389, 829.8132920092961, 832.8750687396879, 833.6832003838533, 837.5853952293623, 611.9908201376983, 617.3517806303364, 617.7035023188895, 619.3249358199539, 621.1738387944024, 10834.40410777407, 10967.616133435371, 10970.670879873616, 10988.450577471174, 10999.890001100046, 9459.337846350758, 9740.0, 9854.113129818279, 9979.900200998043, 10148.847767283496, 7921.56431396273, 8304.83390332196, 8424.0, 8466.74599762008, 8482.53346065966, 3134.4828103362915, 3221.6617255188103, 3235.9352812943844, 3236.96763032369, 3268.82021488818, 36444.0, 37124.628753712655, 37225.627743722485, 37298.62701372978, 38274.42588361205, 9177.219936305355, 9224.723258302261, 9406.95296523513, 9491.054333861543, 9498.620055197714, 15180.696386072217, 15217.31522081509, 15228.543143705707, 15240.161791101596, 15250.923745381202, 6161.260648722182, 6287.1198032275515, 6378.17083779115, 6443.452306553995, 6451.161349024691, 3063.081075677288, 3320.568326117589, 3393.372226138172, 3421.26442814791, 3488.110531814371, 2560.948781024369, 2583.3412479817525, 2584.1213987244428, 2586.4439145583788, 2591.4039770852432, 461.5177139888824, 469.9718016918996, 470.5365215262963, 475.4342332624166, 476.0764117611822, 573.8909607174623, 607.4229481992126, 614.9600275982046, 622.7602373086395, 634.1914059573987, 7818.100918394343, 8065.516069035877, 8125.309348705308, 8132.349412047022, 8358.205970432798, 529.4493726524372, 532.0, 532.3718012744921, 562.7242651100931, 622.757124721359, 3774.226283611853, 3903.1022864741267, 4069.9389509157386, 4088.4276201331836, 4165.791710414528, 41760.79119604443, 42090.0, 42213.78893105515, 42271.7886410566, 42361.364579531335, 38021.80989095037, 38585.0, 38680.22639547193, 38837.22325553473, 38979.0, 31655.733770649378, 38157.42763858545, 39081.80459097686, 39919.60080399159, 40101.398479022835, 8029.4379393441895, 8195.139510351328, 8341.499510029418, 8342.708005219789, 8386.32909367237, 31132.533012004384, 31287.0, 31986.36027279488, 32009.8399508001, 32127.839360803046, 31644.0, 37044.0, 39268.0, 39376.0, 39464.40803388009, 10081.294309398565, 10085.344452610558, 10094.949525252327, 10181.796364072825, 10246.846297305397, 11172.217944744116, 11354.886451135382, 11438.370889601152, 11590.88409115898, 11779.941100294443, 10385.0, 10752.731181720206, 10911.672649820519, 11157.163212758913, 11273.887261127284, 10206.54070566841, 10224.079832815083, 10408.843867342148, 10637.574497020032, 10656.467176641292, 10443.895561044596, 10850.457477125954, 10857.945710271399, 10878.238523303293, 10963.616273430393, 9480.146786789222, 9493.240540756584, 9507.88580555012, 9780.951095244478, 9930.106290433896, 8985.191332780081, 9048.864267035868, 9277.350585458953, 9366.454535001649, 9460.810783784149], "unit": "score", "name": "yui.html", "value": 5613.419282174827}], "name": "dromaeo_css", "value": 6202.7254973189365}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 117.0, 109.0, 112.0, 113.0, 112.0, 102.0, 112.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [158.0, 133.0, 155.0, 165.0, 130.0, 153.0, 162.0, 132.0, 171.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 160.0, 162.0, 160.0, 161.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 85.0, 94.0, 72.0, 74.0, 72.0, 101.0, 91.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 96.0, 95.0, 96.0, 133.0, 95.0, 95.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 72.0, 72.0, 74.0, 73.0, 71.0, 83.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.3}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 83.0, 83.0, 84.0, 83.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [129.0, 126.0, 124.0, 123.0, 121.0, 131.0, 128.0, 126.0, 120.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.9}, {"lowerIsBetter": true, "replicates": [140.0, 149.0, 151.0, 145.0, 149.0, 140.0, 148.0, 146.0, 155.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.8}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 69.0, 68.0, 70.0, 70.0, 69.0, 68.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1526.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [186.28912071535024], "unit": "score", "name": "DeltaBlue", "value": 354.92142400000006}, {"lowerIsBetter": false, "replicates": [281.61081385525205], "unit": "score", "name": "Encrypt", "value": 945.2087309999996}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [785.5459544383347], "unit": "score", "name": "Earley", "value": 848.4073989999999}, {"lowerIsBetter": false, "replicates": [12240.963855421687], "unit": "score", "name": "Boyer", "value": 54.4453041338583}, {"lowerIsBetter": false, "replicates": [29200.0], "unit": "score", "name": "RegExp", "value": 31.19811643835619}, {"lowerIsBetter": false, "replicates": [603.5003017501509], "unit": "score", "name": "Splay", "value": 135.030587}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19652.161984222377}]} 01:13:42 INFO - RETURN: dromaeo_css: 6202.73 01:13:42 INFO - RETURN: kraken: 1526.40 01:13:42 INFO - RETURN: v8_7: 19652.16 01:13:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19652.16"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1526.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6202.73"}}} 01:13:42 INFO - Return code: 0 01:13:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:13:42 ERROR - # TBPL SUCCESS # 01:13:42 INFO - Running post-action listener: _resource_record_post_action 01:13:42 INFO - Running post-run listener: _resource_record_post_run 01:13:43 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 12288; Write bytes: 520028160; Read time: 384; Write time: 503440 01:13:43 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 239149056; Read time: 252; Write time: 324248 01:13:43 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 276582400; Read time: 132; Write time: 178524 01:13:43 INFO - Running post-run listener: _upload_blobber_files 01:13:43 INFO - Blob upload gear active. 01:13:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:13:43 INFO - Copying logs to upload dir... 01:13:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.680173 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-17 01:13:42.622505) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 01:13:42.625902) ========= 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=5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010136 build_url: 'https://queue.taskcluster.net/v1/task/Vvj2ZjwUQlWdbGUl6GT6iw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 01:13:42.677403) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:13:42.677723) ========= 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=5752742a61d0f534093fa7a9000001cb-1450342268.590302-1886887973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:13:42.727364) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 01:13:42.727687) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 01:13:42.727997) ========= ========= Total master_lag: 0.21 =========