builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1449074793.67 results: success (0) buildid: 20151202081125 builduid: 2d4a60abb67d4260b6001ad0556bb3c4 revision: 2ec770d354e53708be3887e8e678ce21866d7a8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.665524) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.666172) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.666491) ========= 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=6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006315 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.702890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.703196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.783546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.784000) ========= 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=6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004555 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.836564) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.837052) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.837625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.838096) ========= 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=6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-02 08:46: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% 221M=0s 2015-12-02 08:46:33 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105336 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.964331) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:33.964602) ========= 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=6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019564 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:34.023109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 08:46:34.023463) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2ec770d354e53708be3887e8e678ce21866d7a8e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2ec770d354e53708be3887e8e678ce21866d7a8e --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=6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-02 08:46:34,087 truncating revision to first 12 chars 2015-12-02 08:46:34,087 Setting DEBUG logging. 2015-12-02 08:46:34,087 attempt 1/10 2015-12-02 08:46:34,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2ec770d354e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-02 08:46:35,132 unpacking tar archive at: fx-team-2ec770d354e5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.351098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-02 08:46:35.388365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:35.388645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:35.398859) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:35.399139) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-02 08:46:35.399844) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-02 08:46:35.400120) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:35 INFO - MultiFileLogger online at 20151202 08:46:35 in /builds/slave/test 08:46:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:46:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:35 INFO - {'append_to_log': False, 08:46:35 INFO - 'base_work_dir': '/builds/slave/test', 08:46:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:46:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:35 INFO - 'branch': 'Fx-Team-Non-PGO', 08:46:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:35 INFO - 'config_files': ('talos/linux_config.py',), 08:46:35 INFO - 'default_actions': ('clobber', 08:46:35 INFO - 'read-buildbot-config', 08:46:35 INFO - 'download-and-extract', 08:46:35 INFO - 'populate-webroot', 08:46:35 INFO - 'create-virtualenv', 08:46:35 INFO - 'install', 08:46:35 INFO - 'run-tests'), 08:46:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:35 INFO - 'download_minidump_stackwalk': True, 08:46:35 INFO - 'download_symbols': 'ondemand', 08:46:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:35 INFO - 'installer_path': 'installer.exe', 08:46:35 INFO - 'log_level': 'info', 08:46:35 INFO - 'log_name': 'talos', 08:46:35 INFO - 'log_to_console': True, 08:46:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:35 INFO - 'opt_config_files': (), 08:46:35 INFO - 'pip_index': False, 08:46:35 INFO - 'sps_profile': False, 08:46:35 INFO - 'sps_profile_interval': 0, 08:46:35 INFO - 'suite': 'dromaeojs', 08:46:35 INFO - 'system_bits': '64', 08:46:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:35 INFO - 'title': 'talos-linux64-ix-018', 08:46:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:35 INFO - 'use_talos_json': True, 08:46:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:35 INFO - 'work_dir': 'build'} 08:46:35 INFO - ##### 08:46:35 INFO - ##### Running clobber step. 08:46:35 INFO - ##### 08:46:35 INFO - Running pre-action listener: _resource_record_pre_action 08:46:35 INFO - Running main action method: clobber 08:46:35 INFO - rmtree: /builds/slave/test/build 08:46:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:36 INFO - Running post-action listener: _resource_record_post_action 08:46:36 INFO - ##### 08:46:36 INFO - ##### Running read-buildbot-config step. 08:46:36 INFO - ##### 08:46:36 INFO - Running pre-action listener: _resource_record_pre_action 08:46:36 INFO - Running main action method: read_buildbot_config 08:46:36 INFO - Using buildbot properties: 08:46:36 INFO - { 08:46:36 INFO - "properties": { 08:46:36 INFO - "buildnumber": 968, 08:46:36 INFO - "product": "firefox", 08:46:36 INFO - "script_repo_revision": "production", 08:46:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:46:36 INFO - "repository": "", 08:46:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:46:36 INFO - "buildid": "20151202081125", 08:46:36 INFO - "slavename": "talos-linux64-ix-018", 08:46:36 INFO - "pgo_build": "False", 08:46:36 INFO - "basedir": "/builds/slave/test", 08:46:36 INFO - "project": "", 08:46:36 INFO - "platform": "ubuntu64_hw", 08:46:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:46:36 INFO - "slavebuilddir": "test", 08:46:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:46:36 INFO - "branch": "fx-team", 08:46:36 INFO - "repo_path": "integration/fx-team", 08:46:36 INFO - "stage_platform": "linux64", 08:46:36 INFO - "builduid": "2d4a60abb67d4260b6001ad0556bb3c4", 08:46:36 INFO - "revision": "2ec770d354e53708be3887e8e678ce21866d7a8e" 08:46:36 INFO - }, 08:46:36 INFO - "sourcestamp": { 08:46:36 INFO - "repository": "", 08:46:36 INFO - "hasPatch": false, 08:46:36 INFO - "project": "", 08:46:36 INFO - "branch": "fx-team-linux64-talos", 08:46:36 INFO - "changes": [ 08:46:36 INFO - { 08:46:36 INFO - "category": null, 08:46:36 INFO - "files": [ 08:46:36 INFO - { 08:46:36 INFO - "url": null, 08:46:36 INFO - "name": "https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 08:46:36 INFO - } 08:46:36 INFO - ], 08:46:36 INFO - "repository": "", 08:46:36 INFO - "rev": "2ec770d354e53708be3887e8e678ce21866d7a8e", 08:46:36 INFO - "who": "mbanner@mozilla.com", 08:46:36 INFO - "when": 1449074733, 08:46:36 INFO - "number": 6733541, 08:46:36 INFO - "comments": "Bug 1229471 - LoopUI shouldn't try to use toolbar buttons in the hidden window. r=mikedeboer", 08:46:36 INFO - "project": "", 08:46:36 INFO - "at": "Wed 02 Dec 2015 08:45:33", 08:46:36 INFO - "branch": "fx-team-linux64-talos", 08:46:36 INFO - "revlink": "", 08:46:36 INFO - "properties": [ 08:46:36 INFO - [ 08:46:36 INFO - "buildid", 08:46:36 INFO - "20151202081125", 08:46:36 INFO - "Change" 08:46:36 INFO - ], 08:46:36 INFO - [ 08:46:36 INFO - "builduid", 08:46:36 INFO - "2d4a60abb67d4260b6001ad0556bb3c4", 08:46:36 INFO - "Change" 08:46:36 INFO - ], 08:46:36 INFO - [ 08:46:36 INFO - "pgo_build", 08:46:36 INFO - "False", 08:46:36 INFO - "Change" 08:46:36 INFO - ] 08:46:36 INFO - ], 08:46:36 INFO - "revision": "2ec770d354e53708be3887e8e678ce21866d7a8e" 08:46:36 INFO - } 08:46:36 INFO - ], 08:46:36 INFO - "revision": "2ec770d354e53708be3887e8e678ce21866d7a8e" 08:46:36 INFO - } 08:46:36 INFO - } 08:46:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 08:46:36 INFO - Running post-action listener: _resource_record_post_action 08:46:36 INFO - ##### 08:46:36 INFO - ##### Running download-and-extract step. 08:46:36 INFO - ##### 08:46:36 INFO - Running pre-action listener: _resource_record_pre_action 08:46:36 INFO - Running main action method: download_and_extract 08:46:36 INFO - mkdir: /builds/slave/test/build/tests 08:46: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')]} 08:46:36 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json 08:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json 08:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:46:43 INFO - Downloaded 1302 bytes. 08:46:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:46:43 INFO - Using the following test package requirements: 08:46:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:46:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:43 INFO - u'jsshell-linux-x86_64.zip'], 08:46:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:46:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:46:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:46:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:46:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:46:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:46: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')]} 08:46:43 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:46:47 INFO - Downloaded 21774978 bytes. 08:46:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:46:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:46:48 INFO - Return code: 0 08:46:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:46: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')]} 08:46:48 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:46:52 INFO - Downloaded 21774978 bytes. 08:46:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:46:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 08:46:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:46:53 INFO - Return code: 0 08:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:53 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:46:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:46:54 INFO - Downloaded 11132001 bytes. 08:46:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 08:46:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:46:54 INFO - Return code: 0 08:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:54 INFO - https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:46:56 INFO - Downloaded 57675869 bytes. 08:46:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:46:56 INFO - mkdir: /builds/slave/test/properties 08:46:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:56 INFO - Contents: 08:46:56 INFO - build_url:https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 08:46:56 INFO - Running post-action listener: _resource_record_post_action 08:46:56 INFO - Running post-action listener: set_extra_try_arguments 08:46:56 INFO - ##### 08:46:56 INFO - ##### Running populate-webroot step. 08:46:56 INFO - ##### 08:46:56 INFO - Running pre-action listener: _resource_record_pre_action 08:46:56 INFO - Running main action method: populate_webroot 08:46:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:56 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 08:46:56 INFO - '../fennec_ids.txt'], 08:46:56 INFO - 'tests': ['tcheck2']}, 08:46:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:56 INFO - '--tppagecycles', 08:46:56 INFO - '7'], 08:46:56 INFO - 'tests': ['tsvgm']}}, 08:46:56 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:46:56 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:46:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:56 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:46:56 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:46:56 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:46:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:56 INFO - 'talos_options': ['--e10s'], 08:46:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:56 INFO - 'tests': ['damp', 'tps']}, 08:46:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:56 INFO - 'talos_options': ['--e10s'], 08:46:56 INFO - 'tests': ['damp', 'tps']}, 08:46:56 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:46:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:56 INFO - 'other': {'tests': ['a11yr', 08:46:56 INFO - 'ts_paint', 08:46:56 INFO - 'tpaint', 08:46:56 INFO - 'sessionrestore', 08:46:56 INFO - 'sessionrestore_no_auto_restore']}, 08:46:56 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:46:56 INFO - 'tests': ['a11yr', 08:46:56 INFO - 'ts_paint', 08:46:56 INFO - 'tpaint', 08:46:56 INFO - 'sessionrestore', 08:46:56 INFO - 'sessionrestore_no_auto_restore']}, 08:46:56 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:46:56 INFO - 'tests': ['a11yr', 08:46:56 INFO - 'ts_paint', 08:46:56 INFO - 'tpaint', 08:46:56 INFO - 'sessionrestore', 08:46:56 INFO - 'sessionrestore_no_auto_restore']}, 08:46:56 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:46:56 INFO - 'tests': ['a11yr', 08:46:56 INFO - 'ts_paint', 08:46:56 INFO - 'tpaint', 08:46:56 INFO - 'sessionrestore', 08:46:56 INFO - 'sessionrestore_no_auto_restore']}, 08:46:56 INFO - 'other_l64': {'tests': ['a11yr', 08:46:56 INFO - 'ts_paint', 08:46:56 INFO - 'tpaint', 08:46:56 INFO - 'sessionrestore', 08:46:56 INFO - 'sessionrestore_no_auto_restore']}, 08:46:56 INFO - 'other_nol64': {'tests': ['a11yr', 08:46:56 INFO - 'ts_paint', 08:46:56 INFO - 'tpaint', 08:46:56 INFO - 'sessionrestore', 08:46:56 INFO - 'sessionrestore_no_auto_restore']}, 08:46:56 INFO - 'svgr': {'tests': ['tsvgx', 08:46:56 INFO - 'tsvgr_opacity', 08:46:56 INFO - 'tart', 08:46:56 INFO - 'tscrollx', 08:46:56 INFO - 'cart']}, 08:46:56 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:46:56 INFO - 'tests': ['tsvgx', 08:46:56 INFO - 'tsvgr_opacity', 08:46:56 INFO - 'tart', 08:46:56 INFO - 'tscrollx', 08:46:56 INFO - 'cart']}, 08:46:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:56 INFO - 'tests': ['tp5o']}, 08:46:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:56 INFO - 'talos_options': ['--e10s'], 08:46:56 INFO - 'tests': ['tp5o']}, 08:46:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:56 INFO - 'talos_options': ['--xperf_path', 08:46:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:56 INFO - 'tests': ['tp5n']}, 08:46:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:56 INFO - 'talos_options': ['--e10s', 08:46:56 INFO - '--xperf_path', 08:46:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:56 INFO - 'tests': ['tp5n']}}, 08:46:56 INFO - 'talos.zip': {'path': '', 08:46:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:56 INFO - Running post-action listener: _resource_record_post_action 08:46:56 INFO - ##### 08:46:56 INFO - ##### Running create-virtualenv step. 08:46:56 INFO - ##### 08:46:56 INFO - Running pre-action listener: _resource_record_pre_action 08:46:56 INFO - Running main action method: create_virtualenv 08:46:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:46:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:56 INFO - Using real prefix '/usr' 08:46:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:56 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:58 INFO - Installing pip.................done. 08:46:58 INFO - Return code: 0 08:46:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:58 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 0x7f7fc9f3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, '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': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:46:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:46:58 INFO - Using env: {'DISPLAY': ':0', 08:46:58 INFO - 'HOME': '/home/cltbld', 08:46:58 INFO - 'LANG': 'en_US.UTF-8', 08:46:58 INFO - 'LANGUAGE': 'en_US:en', 08:46:58 INFO - 'LOGNAME': 'cltbld', 08:46:58 INFO - 'MAIL': '/var/mail/cltbld', 08:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:58 INFO - 'MOZ_NO_REMOTE': '1', 08:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:58 INFO - 'NO_EM_RESTART': '1', 08:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:58 INFO - 'PWD': '/builds/slave/test', 08:46:58 INFO - 'SHELL': '/bin/bash', 08:46:58 INFO - 'SHLVL': '1', 08:46:58 INFO - 'TERM': 'linux', 08:46:58 INFO - 'TMOUT': '86400', 08:46:58 INFO - 'USER': 'cltbld', 08:46:58 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:58 INFO - '_': '/tools/buildbot/bin/python'} 08:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:46:58 INFO - Cleaning up... 08:46:58 INFO - Return code: 0 08:46:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:58 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 0x7f7fc9f3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, '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': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:46:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:46:58 INFO - Using env: {'DISPLAY': ':0', 08:46:58 INFO - 'HOME': '/home/cltbld', 08:46:58 INFO - 'LANG': 'en_US.UTF-8', 08:46:58 INFO - 'LANGUAGE': 'en_US:en', 08:46:58 INFO - 'LOGNAME': 'cltbld', 08:46:58 INFO - 'MAIL': '/var/mail/cltbld', 08:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:58 INFO - 'MOZ_NO_REMOTE': '1', 08:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:46:58 INFO - 'NO_EM_RESTART': '1', 08:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:58 INFO - 'PWD': '/builds/slave/test', 08:46:58 INFO - 'SHELL': '/bin/bash', 08:46:58 INFO - 'SHLVL': '1', 08:46:58 INFO - 'TERM': 'linux', 08:46:58 INFO - 'TMOUT': '86400', 08:46:58 INFO - 'USER': 'cltbld', 08:46:58 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:58 INFO - '_': '/tools/buildbot/bin/python'} 08:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:59 INFO - Downloading/unpacking psutil>=0.7.1 08:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:47:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:00 INFO - Installing collected packages: psutil 08:47:00 INFO - Running setup.py install for psutil 08:47:01 INFO - building 'psutil._psutil_linux' extension 08:47:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:47:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:47:01 INFO - building 'psutil._psutil_posix' extension 08:47:01 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:47:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:47:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:01 INFO - Successfully installed psutil 08:47:01 INFO - Cleaning up... 08:47:01 INFO - Return code: 0 08:47:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7fc9f3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, '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': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:47:01 INFO - Using env: {'DISPLAY': ':0', 08:47:01 INFO - 'HOME': '/home/cltbld', 08:47:01 INFO - 'LANG': 'en_US.UTF-8', 08:47:01 INFO - 'LANGUAGE': 'en_US:en', 08:47:01 INFO - 'LOGNAME': 'cltbld', 08:47:01 INFO - 'MAIL': '/var/mail/cltbld', 08:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:01 INFO - 'MOZ_NO_REMOTE': '1', 08:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:01 INFO - 'NO_EM_RESTART': '1', 08:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:01 INFO - 'PWD': '/builds/slave/test', 08:47:01 INFO - 'SHELL': '/bin/bash', 08:47:01 INFO - 'SHLVL': '1', 08:47:01 INFO - 'TERM': 'linux', 08:47:01 INFO - 'TMOUT': '86400', 08:47:01 INFO - 'USER': 'cltbld', 08:47:01 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:01 INFO - '_': '/tools/buildbot/bin/python'} 08:47:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:47:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:47:03 INFO - Installing collected packages: mozsystemmonitor 08:47:03 INFO - Running setup.py install for mozsystemmonitor 08:47:03 INFO - Successfully installed mozsystemmonitor 08:47:03 INFO - Cleaning up... 08:47:03 INFO - Return code: 0 08:47:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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', '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 0x7f7fc9f3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, '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': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:47: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 blobuploader==1.2.4 08:47:03 INFO - Using env: {'DISPLAY': ':0', 08:47:03 INFO - 'HOME': '/home/cltbld', 08:47:03 INFO - 'LANG': 'en_US.UTF-8', 08:47:03 INFO - 'LANGUAGE': 'en_US:en', 08:47:03 INFO - 'LOGNAME': 'cltbld', 08:47:03 INFO - 'MAIL': '/var/mail/cltbld', 08:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:03 INFO - 'MOZ_NO_REMOTE': '1', 08:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:03 INFO - 'NO_EM_RESTART': '1', 08:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:03 INFO - 'PWD': '/builds/slave/test', 08:47:03 INFO - 'SHELL': '/bin/bash', 08:47:03 INFO - 'SHLVL': '1', 08:47:03 INFO - 'TERM': 'linux', 08:47:03 INFO - 'TMOUT': '86400', 08:47:03 INFO - 'USER': 'cltbld', 08:47:03 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:03 INFO - '_': '/tools/buildbot/bin/python'} 08:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:03 INFO - Downloading/unpacking blobuploader==1.2.4 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:05 INFO - Downloading blobuploader-1.2.4.tar.gz 08:47:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:47:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:47:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:06 INFO - Downloading docopt-0.6.1.tar.gz 08:47:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:06 INFO - Running setup.py install for blobuploader 08:47:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:47:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:47:06 INFO - Running setup.py install for requests 08:47:06 INFO - Running setup.py install for docopt 08:47:06 INFO - Successfully installed blobuploader requests docopt 08:47:06 INFO - Cleaning up... 08:47:06 INFO - Return code: 0 08:47:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:06 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 0x7f7fc9f3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, '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': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:06 INFO - Using env: {'DISPLAY': ':0', 08:47:06 INFO - 'HOME': '/home/cltbld', 08:47:06 INFO - 'LANG': 'en_US.UTF-8', 08:47:06 INFO - 'LANGUAGE': 'en_US:en', 08:47:06 INFO - 'LOGNAME': 'cltbld', 08:47:06 INFO - 'MAIL': '/var/mail/cltbld', 08:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:06 INFO - 'MOZ_NO_REMOTE': '1', 08:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:06 INFO - 'NO_EM_RESTART': '1', 08:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:06 INFO - 'PWD': '/builds/slave/test', 08:47:06 INFO - 'SHELL': '/bin/bash', 08:47:06 INFO - 'SHLVL': '1', 08:47:06 INFO - 'TERM': 'linux', 08:47:06 INFO - 'TMOUT': '86400', 08:47:06 INFO - 'USER': 'cltbld', 08:47:06 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:06 INFO - '_': '/tools/buildbot/bin/python'} 08:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:07 INFO - Running setup.py (path:/tmp/pip-UDsIsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:07 INFO - Running setup.py (path:/tmp/pip-BbahDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:07 INFO - Running setup.py (path:/tmp/pip-OMhgY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:07 INFO - Running setup.py (path:/tmp/pip-bHVFRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:07 INFO - Running setup.py (path:/tmp/pip-1EYhTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:07 INFO - Running setup.py (path:/tmp/pip-sn5PNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:07 INFO - Running setup.py (path:/tmp/pip-OTYmp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:07 INFO - Running setup.py (path:/tmp/pip-uH6ZO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:07 INFO - Running setup.py (path:/tmp/pip-qUMjrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:07 INFO - Running setup.py (path:/tmp/pip-ligZpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:07 INFO - Running setup.py (path:/tmp/pip-KRII3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:07 INFO - Running setup.py (path:/tmp/pip-fsvBDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:07 INFO - Running setup.py (path:/tmp/pip-PF3XWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:08 INFO - Running setup.py (path:/tmp/pip-i2oe0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:08 INFO - Running setup.py (path:/tmp/pip-oHTnzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:08 INFO - Running setup.py (path:/tmp/pip-PSw3Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:08 INFO - Running setup.py (path:/tmp/pip-W7pRxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:47:08 INFO - Running setup.py install for manifestparser 08:47:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Running setup.py install for mozcrash 08:47:08 INFO - Running setup.py install for mozdebug 08:47:08 INFO - Running setup.py install for mozdevice 08:47:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Running setup.py install for mozfile 08:47:08 INFO - Running setup.py install for mozhttpd 08:47:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:47:08 INFO - Running setup.py install for mozinfo 08:47:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozInstall 08:47:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozleak 08:47:09 INFO - Running setup.py install for mozlog 08:47:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for moznetwork 08:47:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozprocess 08:47:09 INFO - Running setup.py install for mozprofile 08:47:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozrunner 08:47:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:47:09 INFO - Running setup.py install for mozscreenshot 08:47:09 INFO - Running setup.py install for moztest 08:47:09 INFO - Running setup.py install for mozversion 08:47:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:47:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:47:10 INFO - Cleaning up... 08:47:10 INFO - Return code: 0 08:47:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:10 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 0x7f7fc9f3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, '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': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:10 INFO - Using env: {'DISPLAY': ':0', 08:47:10 INFO - 'HOME': '/home/cltbld', 08:47:10 INFO - 'LANG': 'en_US.UTF-8', 08:47:10 INFO - 'LANGUAGE': 'en_US:en', 08:47:10 INFO - 'LOGNAME': 'cltbld', 08:47:10 INFO - 'MAIL': '/var/mail/cltbld', 08:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:10 INFO - 'MOZ_NO_REMOTE': '1', 08:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:10 INFO - 'NO_EM_RESTART': '1', 08:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:10 INFO - 'PWD': '/builds/slave/test', 08:47:10 INFO - 'SHELL': '/bin/bash', 08:47:10 INFO - 'SHLVL': '1', 08:47:10 INFO - 'TERM': 'linux', 08:47:10 INFO - 'TMOUT': '86400', 08:47:10 INFO - 'USER': 'cltbld', 08:47:10 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:10 INFO - '_': '/tools/buildbot/bin/python'} 08:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:10 INFO - Running setup.py (path:/tmp/pip-lz7hWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:10 INFO - Running setup.py (path:/tmp/pip-YBpZU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:10 INFO - Running setup.py (path:/tmp/pip-e4kPew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:10 INFO - Running setup.py (path:/tmp/pip-OVqDA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:10 INFO - Running setup.py (path:/tmp/pip-OgCPmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:10 INFO - Running setup.py (path:/tmp/pip-H6xlkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:10 INFO - Running setup.py (path:/tmp/pip-z38VwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:10 INFO - Running setup.py (path:/tmp/pip-ZwWJ06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:10 INFO - Running setup.py (path:/tmp/pip-pKdopj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:10 INFO - Running setup.py (path:/tmp/pip-AhtU2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:11 INFO - Running setup.py (path:/tmp/pip-DMb3wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:11 INFO - Running setup.py (path:/tmp/pip-HI8hd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:11 INFO - Running setup.py (path:/tmp/pip-X8c6hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:11 INFO - Running setup.py (path:/tmp/pip-jEDU1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:11 INFO - Running setup.py (path:/tmp/pip-cOO_yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:11 INFO - Running setup.py (path:/tmp/pip-4eCpmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:11 INFO - Running setup.py (path:/tmp/pip-jMPD0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:13 INFO - Downloading blessings-1.5.1.tar.gz 08:47:13 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:13 INFO - Installing collected packages: blessings 08:47:13 INFO - Running setup.py install for blessings 08:47:13 INFO - Successfully installed blessings 08:47:13 INFO - Cleaning up... 08:47:13 INFO - Return code: 0 08:47:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:13 INFO - Reading from file tmpfile_stdout 08:47:13 INFO - Current package versions: 08:47:13 INFO - argparse == 1.2.1 08:47:13 INFO - blessings == 1.5.1 08:47:13 INFO - blobuploader == 1.2.4 08:47:13 INFO - docopt == 0.6.1 08:47:13 INFO - manifestparser == 1.1 08:47:13 INFO - mozInstall == 1.12 08:47:13 INFO - mozcrash == 0.16 08:47:13 INFO - mozdebug == 0.1 08:47:13 INFO - mozdevice == 0.47 08:47:13 INFO - mozfile == 1.2 08:47:13 INFO - mozhttpd == 0.7 08:47:13 INFO - mozinfo == 0.9 08:47:13 INFO - mozleak == 0.1 08:47:13 INFO - mozlog == 3.1 08:47:13 INFO - moznetwork == 0.27 08:47:13 INFO - mozprocess == 0.22 08:47:13 INFO - mozprofile == 0.27 08:47:13 INFO - mozrunner == 6.11 08:47:13 INFO - mozscreenshot == 0.1 08:47:13 INFO - mozsystemmonitor == 0.0 08:47:13 INFO - moztest == 0.7 08:47:13 INFO - mozversion == 1.4 08:47:13 INFO - psutil == 3.1.1 08:47:13 INFO - requests == 1.2.3 08:47:13 INFO - wsgiref == 0.1.2 08:47:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f7fc9f3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, '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': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:13 INFO - Using env: {'DISPLAY': ':0', 08:47:13 INFO - 'HOME': '/home/cltbld', 08:47:13 INFO - 'LANG': 'en_US.UTF-8', 08:47:13 INFO - 'LANGUAGE': 'en_US:en', 08:47:13 INFO - 'LOGNAME': 'cltbld', 08:47:13 INFO - 'MAIL': '/var/mail/cltbld', 08:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:13 INFO - 'MOZ_NO_REMOTE': '1', 08:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:13 INFO - 'NO_EM_RESTART': '1', 08:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:13 INFO - 'PWD': '/builds/slave/test', 08:47:13 INFO - 'SHELL': '/bin/bash', 08:47:13 INFO - 'SHLVL': '1', 08:47:13 INFO - 'TERM': 'linux', 08:47:13 INFO - 'TMOUT': '86400', 08:47:13 INFO - 'USER': 'cltbld', 08:47:13 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:13 INFO - '_': '/tools/buildbot/bin/python'} 08:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:47:13 INFO - Cleaning up... 08:47:13 INFO - Return code: 0 08:47:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fc9f3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, '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': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:47:13 INFO - Using env: {'DISPLAY': ':0', 08:47:13 INFO - 'HOME': '/home/cltbld', 08:47:13 INFO - 'LANG': 'en_US.UTF-8', 08:47:13 INFO - 'LANGUAGE': 'en_US:en', 08:47:13 INFO - 'LOGNAME': 'cltbld', 08:47:13 INFO - 'MAIL': '/var/mail/cltbld', 08:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:13 INFO - 'MOZ_NO_REMOTE': '1', 08:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:13 INFO - 'NO_EM_RESTART': '1', 08:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:13 INFO - 'PWD': '/builds/slave/test', 08:47:13 INFO - 'SHELL': '/bin/bash', 08:47:13 INFO - 'SHLVL': '1', 08:47:13 INFO - 'TERM': 'linux', 08:47:13 INFO - 'TMOUT': '86400', 08:47:13 INFO - 'USER': 'cltbld', 08:47:13 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:13 INFO - '_': '/tools/buildbot/bin/python'} 08:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:14 INFO - Downloading/unpacking jsonschema 08:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:47:15 INFO - Downloading/unpacking functools32 (from jsonschema) 08:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:15 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:47:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:16 INFO - warning: no files found matching '*.txt' 08:47:16 INFO - no previously-included directories found matching 'build' 08:47:16 INFO - no previously-included directories found matching 'dist' 08:47:16 INFO - no previously-included directories found matching '.git*' 08:47:16 INFO - Installing collected packages: jsonschema, functools32 08:47:16 INFO - Running setup.py install for functools32 08:47:16 INFO - warning: no files found matching '*.txt' 08:47:16 INFO - no previously-included directories found matching 'build' 08:47:16 INFO - no previously-included directories found matching 'dist' 08:47:16 INFO - no previously-included directories found matching '.git*' 08:47:16 INFO - Successfully installed jsonschema functools32 08:47:16 INFO - Cleaning up... 08:47:16 INFO - Return code: 0 08:47:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fc9f3cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efa240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, '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': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:47:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:47:16 INFO - Using env: {'DISPLAY': ':0', 08:47:16 INFO - 'HOME': '/home/cltbld', 08:47:16 INFO - 'LANG': 'en_US.UTF-8', 08:47:16 INFO - 'LANGUAGE': 'en_US:en', 08:47:16 INFO - 'LOGNAME': 'cltbld', 08:47:16 INFO - 'MAIL': '/var/mail/cltbld', 08:47:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:16 INFO - 'MOZ_NO_REMOTE': '1', 08:47:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:16 INFO - 'NO_EM_RESTART': '1', 08:47:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:16 INFO - 'PWD': '/builds/slave/test', 08:47:16 INFO - 'SHELL': '/bin/bash', 08:47:16 INFO - 'SHLVL': '1', 08:47:16 INFO - 'TERM': 'linux', 08:47:16 INFO - 'TMOUT': '86400', 08:47:16 INFO - 'USER': 'cltbld', 08:47:16 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:47:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:16 INFO - '_': '/tools/buildbot/bin/python'} 08:47:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:16 INFO - Downloading/unpacking flake8 08:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:47:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:47:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:47:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:47:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:47:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:18 INFO - no previously-included directories found matching 'docs/_build' 08:47:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:47:18 INFO - Running setup.py install for pep8 08:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:18 INFO - no previously-included directories found matching 'docs/_build' 08:47:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:47:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:47:18 INFO - Cleaning up... 08:47:19 INFO - Return code: 0 08:47:19 INFO - Running post-action listener: _resource_record_post_action 08:47:19 INFO - Running post-action listener: _start_resource_monitoring 08:47:19 INFO - Starting resource monitoring. 08:47:19 INFO - ##### 08:47:19 INFO - ##### Running install step. 08:47:19 INFO - ##### 08:47:19 INFO - Running pre-action listener: _resource_record_pre_action 08:47:19 INFO - Running main action method: install 08:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:19 INFO - Reading from file tmpfile_stdout 08:47:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:19 INFO - Reading from file tmpfile_stdout 08:47:19 INFO - Output received: 08:47:19 INFO - Usage: mozinstall [options] installer 08:47:19 INFO - Options: 08:47:19 INFO - -h, --help show this help message and exit 08:47:19 INFO - -d DEST, --destination=DEST 08:47:19 INFO - Directory to install application into. [default: 08:47:19 INFO - "/builds/slave/test"] 08:47:19 INFO - --app=APP Application being installed. [default: firefox] 08:47:19 INFO - mkdir: /builds/slave/test/build/application 08:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:47:33 INFO - Reading from file tmpfile_stdout 08:47:33 INFO - Output received: 08:47:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:33 INFO - Running post-action listener: _resource_record_post_action 08:47:33 INFO - ##### 08:47:33 INFO - ##### Running run-tests step. 08:47:33 INFO - ##### 08:47:33 INFO - Running pre-action listener: _resource_record_pre_action 08:47:33 INFO - Running main action method: run_tests 08:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:33 INFO - Python 2.7.3 08:47:33 INFO - Return code: 0 08:47:33 INFO - grabbing minidump binary from tooltool 08:47:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:33 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 0x1f890b0>, '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 0x1f89fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:47:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:47:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:33 INFO - Return code: 0 08:47:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:47:34 INFO - Return code: 0 08:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 08:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 08:47:34 INFO - Using env: {'DISPLAY': ':0', 08:47:34 INFO - 'HOME': '/home/cltbld', 08:47:34 INFO - 'LANG': 'en_US.UTF-8', 08:47:34 INFO - 'LANGUAGE': 'en_US:en', 08:47:34 INFO - 'LOGNAME': 'cltbld', 08:47:34 INFO - 'MAIL': '/var/mail/cltbld', 08:47:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:34 INFO - 'MOZ_NO_REMOTE': '1', 08:47:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:34 INFO - 'NO_EM_RESTART': '1', 08:47:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:34 INFO - 'PWD': '/builds/slave/test', 08:47:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:34 INFO - 'SHELL': '/bin/bash', 08:47:34 INFO - 'SHLVL': '1', 08:47:34 INFO - 'TERM': 'linux', 08:47:34 INFO - 'TMOUT': '86400', 08:47:34 INFO - 'USER': 'cltbld', 08:47:34 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550', 08:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:34 INFO - '_': '/tools/buildbot/bin/python'} 08:47:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 08:47:35 INFO - mozversion INFO | application_buildid: 20151202081125 08:47:35 INFO - mozversion INFO | application_changeset: 2ec770d354e53708be3887e8e678ce21866d7a8e 08:47:35 INFO - mozversion INFO | application_display_name: Nightly 08:47:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:35 INFO - mozversion INFO | application_name: Firefox 08:47:35 INFO - mozversion INFO | application_remotingname: firefox 08:47:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 08:47:35 INFO - mozversion INFO | application_vendor: Mozilla 08:47:35 INFO - mozversion INFO | application_version: 45.0a1 08:47:35 INFO - mozversion INFO | platform_buildid: 20151202081125 08:47:35 INFO - mozversion INFO | platform_changeset: 2ec770d354e53708be3887e8e678ce21866d7a8e 08:47:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 08:47:35 INFO - mozversion INFO | platform_version: 45.0a1 08:47:35 INFO - 2015-12-02 08:47:35,039 DEBUG : using testdate: 1449074855 08:47:35 INFO - 2015-12-02 08:47:35,039 DEBUG : actual date: 1449074855 08:47:35 INFO - 2015-12-02 08:47:35,088 INFO : starting webserver on 'localhost:43404' 08:47:35 INFO - 2015-12-02 08:47:35,089 INFO : Starting test suite talos-linux64-ix-018 08:47:35 INFO - 2015-12-02 08:47:35,089 INFO : Starting test dromaeo_css 08:47:35 INFO - 2015-12-02 08:47:35,089 DEBUG : operating with platform_type : linux_ 08:47:35 INFO - 2015-12-02 08:47:35,090 INFO : Initialising browser for dromaeo_css test... 08:47:35 INFO - 2015-12-02 08:47:35,107 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp184V1N/profile http://localhost:43404/getInfo.html 08:47:39 INFO - 2015-12-02 08:47:39,595 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:47:39 INFO - 2015-12-02 08:47:39,595 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:47:39 INFO - 2015-12-02 08:47:39,596 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:47:39 INFO - 2015-12-02 08:47:39,596 DEBUG : BROWSER_OUTPUT: __metrics 08:47:39 INFO - 2015-12-02 08:47:39,692 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] 08:47:39 INFO - 2015-12-02 08:47:39,692 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:47:39 ERROR - 2015-12-02 08:47:39,773 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 08:47:40 INFO - 2015-12-02 08:47:40,051 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. 08:47:40 INFO - 2015-12-02 08:47:40,727 INFO : Browser initialized. 08:47:40 INFO - 2015-12-02 08:47:40,727 INFO : Running cycle 1/1 for dromaeo_css test... 08:47:40 INFO - 2015-12-02 08:47:40,728 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp184V1N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:47:52 INFO - 2015-12-02 08:47:52,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 140697600 08:47:52 INFO - 2015-12-02 08:47:52,736 DEBUG : BROWSER_OUTPUT: 08:48:43 INFO - 2015-12-02 08:48:43,966 DEBUG : BROWSER_OUTPUT: 1449074923965 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:50:56 INFO - 2015-12-02 08:50:56,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43404/tests/dromaeo/cssquery-ext.html) 08:50:57 INFO - 2015-12-02 08:50:57,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 260571136 08:50:57 INFO - 2015-12-02 08:50:57,209 DEBUG : BROWSER_OUTPUT: 08:53:59 INFO - 2015-12-02 08:53:59,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/dromaeo/cssquery-ext.html (next: http://localhost:43404/tests/dromaeo/cssquery-jquery.html) 08:54:00 INFO - 2015-12-02 08:54:00,320 DEBUG : BROWSER_OUTPUT: RSS: Main: 221405184 08:54:00 INFO - 2015-12-02 08:54:00,320 DEBUG : BROWSER_OUTPUT: 08:57:02 INFO - 2015-12-02 08:57:02,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43404/tests/dromaeo/cssquery-mootools.html) 08:57:02 INFO - 2015-12-02 08:57:02,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 222453760 08:57:02 INFO - 2015-12-02 08:57:02,987 DEBUG : BROWSER_OUTPUT: 09:00:04 INFO - 2015-12-02 09:00:04,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43404/tests/dromaeo/cssquery-prototype.html) 09:00:05 INFO - 2015-12-02 09:00:05,581 DEBUG : BROWSER_OUTPUT: RSS: Main: 200380416 09:00:05 INFO - 2015-12-02 09:00:05,581 DEBUG : BROWSER_OUTPUT: 09:03:08 INFO - 2015-12-02 09:03:08,424 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43404/tests/dromaeo/cssquery-yui.html) 09:03:09 INFO - 2015-12-02 09:03:09,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 179990528 09:03:09 INFO - 2015-12-02 09:03:09,010 DEBUG : BROWSER_OUTPUT: 09:06:11 INFO - 2015-12-02 09:06:11,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/dromaeo/cssquery-yui.html (next: http://localhost:43404/tests/dromaeo/cssquery-dojo.html) 09:06:11 INFO - 2015-12-02 09:06:11,725 DEBUG : BROWSER_OUTPUT: RSS: Main: 249843712 09:06:11 INFO - 2015-12-02 09:06:11,725 DEBUG : BROWSER_OUTPUT: 09:06:11 INFO - 2015-12-02 09:06:11,726 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:06:11 INFO - 2015-12-02 09:06:11,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:06:11 INFO - 2015-12-02 09:06:11,728 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:06:11 INFO - 2015-12-02 09:06:11,728 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:06:11 INFO - 2015-12-02 09:06:11,729 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2625.527405067088;2699.122785094845;2706.215197592698;2714.362124900648;2720.251930719053;4598.241290187124;4650.441946966364;4685.64857635677;4685.8125674973;4741.45473270574;4581.335706322589;4627.537246275371;4695.366125573047;4696.342512048307;4709.2229782086;4257.276263035284;4290.141971605676;4327.913441731163;4346.5436129206455;4412.0955204183065;4222.324428091506;4415.116976604692;4426.933595996063;4469.173202957447;4472.9329060063965;4214.283571792803;4284.978575107105;4319.978400108011;4325.394444777718;4334.783260836945;4314.115606300701;4328.696991210617;4331.06882020364;4353.62994145498;4368.475782906072;4175.31107367284;4286.057067445188;4292.484901811771;4296.226679197744;4356.8257269709175;4505.932411013805;4521.208788462006;4540.931886021713;4543.40935678363;4546.568076032805;4925.704457732511;4947.628927830391;5029.145045342264;5057.5701065409485;5071.594272458195;5067.873303167414;5068.493150684939;5069.315642388267;5088.592912566985;5098.949010509885;4703.129920964564;4703.45910220329;4704.5765881070865;4710.5760481556135;4760.952390476085;4948.925766113512;5065.620078494054;5066.797328106908;5067.189249720027;5068.594512438996;4799.66402351839;4875.95124048762;4895.192293271571;4915.582175515121;4949.059678661043;5076.720780357042;5085.694858308513;5114.232865070269;5120.078385890575;5120.334356533701;5055.646104772704;5058.721770302595;5061.215511595708;5062.190049592047;5096.745162741848;4780.665353425296;4895.779689913962;4896.975515122473;4899.730514821719;5001;4111.157212771374;4143.56492568282;4171.290880550314;4177.081042170717;4221.472315960505;3656.981715091461;3663;3669.559652841676;3700.2229531798084;3705.0181701849033;4157.958420415757;4248.065425606362;4363.214621368121;4367.344898265222;4407.6914615976575;4843.903121937541;4951;4980.77586508608;5016.347874776256;5039.596832253411;4341.60925516705;4342.261815491374;4348.695591308578;4350;4386.122775444924;4280.614744672995;4399.340098985178;4454.28731402974;4476.753778542212;4503.144402563503;4627.745473998895;4687.67186296956;4699.459562150397;4702.76486175683;4742.004179122285;5025.974870125626;5027.949720502895;5028.497150284942;5031.4213865405945;5073.492650735045;4703.059388122458;4800.975995120002;4807.495213002724;4814.037192561572;4849.248366503198;4872.975635121802;4916.459189489082;4917.385326834145;4920.8682003138765;4944.950550494593;5048.59611231108;5076.873078173076;5093.23601459784;5095.0574143783515;5153.665011774223;4686.437627484724;4913.680610760289;4917.704937703749;4920.581750551243;4970.130227210296;4733.5503127202865;4851.054044461296;4853.708777473363;4865.6107511398295;4896.706197628154;4746.691465054761;4770.761461926959;4775.5224477551965;4787.928181077217;4825.469198388104;4767.427908650984;4928.2607608857525;4935.087008903364;4937.21004639256;4976.5023497649945;4700.6474514410875;4721.976390118028;4742.217534106834;4774.737389443614;4783.378160839069 09:06:11 INFO - 2015-12-02 09:06:11,733 DEBUG : BROWSER_OUTPUT: |1;ext.html;553.9208862734181;570.2102587915738;577.2236342119847;581.3895409819689;588.5938702295416;26881;35494.112647183836;36114.638853611454;36197.81901090491;36254.27491450176;38539.807300963526;38787.61212387875;38825.41761873567;38829.22341553167;38960.41559376611;6961.756338528153;7111.8222044448785;7729.188435214306;7860.0960889497865;7867.409944254176;9962.203023758118;10292.948535257314;10320.483975801217;10324.638637647684;10333.844992325121;9998.05018523239;10078.34490758102;10081.09270165685;10099.394036357842;10105.54525046371;7190.173130090028;7371.041764570571;9699.66051188212;9840.507974601278;10021.649242276486;9562.521873906346;9774.413535187912;9776.90223097767;9780.217582593375;9782.168515676176;33780.662193378;34253.143671408165;34323.828380858184;34361.82819085914;34487;2855.957160642592;2861.399106187703;2864.799464037518;3064.0195137555993;3365.7643964922463;28159.718402815914;28184.71815281862;28288.717112828814;28398.29004274889;28533.144005679864;3167.683231676837;3254.8372581370836;3260.559824423696;3269.2317305433203;3300.624885222624;209595;211584;211614;212459;212731;49925.50074499209;50494;50766.74616626967;53817.46182538203;54362;46272;47525.76237118861;48072.519274807506;48279.27581086286;48349;14052.789208161887;14150.716985660434;14260.42958281657;14276.14343139415;14279.071860329046;10693.251472397013;10750.086242669304;10755.677329680122;10757.56969721218;10765.623203187852;18651.253949841856;18717.438476845717;18727.531811704543;18897.24411023571;18918.81081189198;7199.172095209014;7511.49770045993;7543.057117860268;7557.319841214317;7607.201243869425;878.6221924572368;888.3159966825508;909.2362415570819;910.2990697163148;984.2913102566141;25441.236762897144;25675.871620641778;26100;26535;26558.86720566385;948.5873644964324;972.7616733900239;986.556049777603;986.7631768375538;993.3245393132739;13633;14094.154350738989;14323;14422.350994205286;15617.843821561866;253592;256317;256559;257699;258339;45593;45670.771646142224;45826.312605310944;45877.31184032242;45912.3113153303;1201.7896868048056;1204.9216800907914;1211.236920739928;1212.2423485321674;1224.8591411987736;26543.469130617665;27173.184804455897;27316.726832732213;27396.58905116385;27489.587656185573;35619.10952226111;36169.45745813762;36241.27517449689;42063.579364205965;42998.35502467528;173024;174363;174408;174714;174863;24290.54256744601;24708.752912470645;25959.351016224744;26280.080197193005;26337.28807627498;36446.63553364432;37113;37361.81319093387;37948.81025594854;38258.0435489115;31140.53289200709;32439.675603243664;33371;33735.32529349448;34126.488102677984;32375.51436728498;32399;32438.189045274055;32501.837490812395;32821.67178328186;32728.34543309168;33074.83462582768;33135;33176.1705957353;33252.16869578183;28427;29510.40979180447;29934;30231.244218894702;30449.695503045572;22984.770152298934;23227.88386058059;23433.297001089995;23700.762992369855;23774.643380349655 09:06:11 INFO - 2015-12-02 09:06:11,734 DEBUG : BROWSER_OUTPUT: |2;jquery.html;330.7563561010601;332.6424094098843;332.7437872837914;334.41644330643027;338.629201024878;12458.12793104483;12885.613431597043;14922.10467371957;15313.081215127086;15940.202989850519;12162.27026378418;15507.612309692264;15943.760843587326;16296.185190740445;16496.505104846845;5459.3994660587405;5479.205515200293;5589.944100558983;5635.154726790973;5638.238837756912;3886.533615966088;4038.899027524306;5560.304961879765;5614.157876318564;6496.837579060514;6570.080188773575;6628.834279143036;6639.8340041499105;6662.533622646417;6663.666816659172;6398.2322121345505;6549.34506549346;6564.146660934096;6571.178602674666;6573.572717773353;6127.988881834492;6211.726596047799;6259.499240060784;6273.937260627381;6326.272478664966;19998.600027999357;20640.69038964417;20723.378298651063;20885.37343879686;21647.45881352963;1966.5673551818577;1994.1923520974028;2006.7190593316948;2080.9791902080938;2105.5157313817754;13736.381862816197;13884.652883677887;14062.437502499888;14091.365888534938;14158.716825663532;1836.7153091270875;1895.1566552883971;2055;2177.825773938081;2191.824654027674;60539.394606053815;64161.358386416;64563.3543664562;65020.34979650143;65227.673861630385;15497.767533487007;15596.220188990505;15616.687666246611;15772.132532710582;15777.368905243662;23487.41281467943;23637.527249454914;23819.404514887265;23820.04719811223;23822.545730869275;8756.824863502694;8843.734687959372;8856.335774816915;8909.73270801877;8930.776730581658;7327.523710958771;7340.11918569775;7356.558606483628;7382.852342953111;7399.223081576464;7524.699012039567;7620.161782203953;7657.46397752152;7669.693212271447;7807.609619519001;1704.250129942821;1709.1454272863568;1716.476474675211;2133.743950725923;3122.5628412022334;364.54249916354803;365.1710616899623;384.1452767592141;400.3894061556092;842.7893026743315;9160.358774885828;9849.162821160138;13432.865671343357;15125.848741512664;15576.45482408133;835.1231207232381;839.5088873009358;867.9609417576224;925.3383830561047;933.9772948621248;8666.523341216294;8966.820663586823;9083.273338132933;9130.31522635805;9278.164965153168;504628;509253;514399;523138;523365;69239.65380173067;69449.65275173592;71072.64463677649;71454.2854571458;71519.28480715126;1077.8437126616755;1083.101026148295;1084.6529110684505;1101.0382072225848;1104.1773878460438;14352.354144063751;14407.135571865721;14486.565403037926;14591.176102987127;14656.267186640413;29512.852435738543;29993;30028.549571756004;30299.242518937204;31280;41872;42883.35674964941;45640.771796140805;46780.53219467762;47016.529834701214;8109.351251899716;8664.523451210243;8670.479771213748;8676.132386761274;8676.652933882826;9744.658936937172;9810.313278070467;12302.569410070604;15442.30509627047;15799.447019354267;13049.217046977212;13603.659908502366;13608.115472494255;13763.655908601964;13764.93117534406;13008.544700935421;13413.597592072254;13463.932680336535;13597.79603305971;13836.584902452943;10551.472426378803;10621.575136994743;13153.408096635865;13249.80125298102;13700.45198192061;7964.2433968772875;8005.599720014093;8009.5995200238585;8018.4787988780545;8827.602757876039;8558.49378443099;8590.871136933076;8624.741257762276;13566.728665426834;14081.225532595805 09:06:11 INFO - 2015-12-02 09:06:11,734 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1256.4597223194023;1467.8899082568807;1508.0348576910776;1615.6526346835435;1725.670345034204;6082.30053543842;6914.619695916723;7062.117235345582;7065.940108983655;7067.081279433679;7116.039334689815;7291.4895957283015;7298.416126709863;7309.305615966488;7316.231795661445;2064.3806857942595;2112.8837913914726;2113.3131732187026;2114.1332053857923;2114.608797372491;2054.130870098832;2060.072967164774;2082.2816128435743;2082.3648787119923;2084.47888027993;1987.4534503011644;2023.7571491420977;2044.0393015282793;2049.047193055229;2051.4871282179456;2070.647989841723;2087.8225350845196;2089.185217765073;2090.644590419625;2093.9999999999923;2041.3569725536556;2076.345951025422;2076.678114892194;2094.2356040045424;2097.8741275523516;5982.132590774313;6123.234595675541;7054;7192.856142877114;7193.604351760651;4002.4996875390575;4104.42538044674;4130.56629053948;4154.792260386968;4158.625723684852;2654.681438227425;2685.167598044593;2713.308106432847;2716.3888125171875;2727.945441091167;797.956112413817;799.8320352725934;1682.175733890385;1685.7387104998745;1709.2906443825798;9091.363604547685;9247.075292470767;9261.583228754655;9267.536623168815;9282.90717092834;3716.2567486502267;3745.6441638044344;3789.3368660484307;3803.809809509569;3838.9808050960123;7858.1356050834365;7867.173946735625;7886.566238856918;7894.684212631545;7901.920980790233;4175.97912010438;4177.415161877339;4195.139996300751;4195.853145139967;4206.85276015338;3856.515241631992;3860.478835357247;3874.1476875087437;3881.7476864003747;3887.7667339959694;3071.8617662205256;3087.5368694695976;3095.1178914009397;3105.82917939511;3128.6245650522083;903.0969030969031;906.71891713569;912.7763697893926;923.2198792020732;924.0343840686498;907.4419232172166;1186.0807873897797;1188.8335633011386;1194.3496547893003;1219.1465973818363;6741.629210393377;6770.32296770319;6791.694373753094;6794.150731158606;6801.353871382211;436.06681701159545;437.0908510298571;438.56143856143854;1108.556577369059;1137.9658610241706;5325.068113080196;5413.350397952192;5442.374126975369;5482.095454250004;5493.560515158778;8441.535715535581;8511.702090426928;8554.315654747605;8581.528015959182;8649;8327.625256863455;8397.874031889527;8440.11378805229;8491.278241349431;8520.74437766868;6721.495887808336;6850.109485766819;6902.344277293649;6907.758228461979;6911.03245545624;6745.3591908768585;6776.932230677828;6827.180738311435;6864.725410983705;6869.896951545631;7563.508371955805;7731.690732370642;7768.262015108556;7800.648970796441;7824.882626760717;7884.448088633741;7893.447458677838;7974.122846486998;7991.960040199761;8020;6264.34224406449;6308.495320374267;6338.207724034496;6350.555461117678;6386.776462823779;6778.017187507685;6896.103506544117;6898.620575868375;6920.861582768417;6927.7228910843005;6052.848678783065;6117.877642447215;6171.691415429121;6266.561340706106;6464.967675161594;6368.64972426521;6480.546361754632;6526.641034743135;6571.474282057519;6604.537682362188;6579.374959378852;6629;6630;6641.535092543669;6643.368879956396;5778.451047150514;6053.576249662481;6055.515558755201;6140.938590614215;6208.255009398901;5516.779328826802;5705.343885453226;5792.275965504312;5929.970350148222;5931.169636251015 09:06:11 INFO - 2015-12-02 09:06:11,736 DEBUG : BROWSER_OUTPUT: |4;prototype.html;289.1960350226371;296.25196379142665;300.3032963524622;303.90730827097724;304.5188602008826;5296.073187192245;5296.947030529698;5337.733113344337;5488.835334939949;5527.55779537637;5337.946620533793;5384.030874442608;5402.081646120159;5406.08096623574;5413.458654134594;3949.5852935441794;4146.087860670647;4151.211269858717;4159.376093585956;4164.937525937105;4009.138035322405;4099.262132816092;4134.607212314825;4152.854650087247;4164.208800327928;4098.323776576861;4117.238310912476;4121.979390103045;4140.337545992642;4164.97917510412;3956.1296514766705;4035.959640403588;4059.289624315733;4169.916601667965;4173.8330466781445;3656.177360093984;3660.1032746976894;3664.175560498893;3679.5400574928135;3688.4467329900463;5174.2238664200295;5183.663061900965;5187.170052791535;5188.377394712621;5199.454057324002;4786.1863483207935;4792;4796.376471058775;4798.280257961299;4800.375951126366;5507.146392309199;5637.915431268534;5641.12562552805;5644.6330988485615;5647.661140331593;4002.3196056670436;4003.7597744135155;4004.619561141687;4005.379166229239;4006.599340065999;5860.09168578871;5945.524358051345;5950.523958083343;5951.553633477506;5952.196453478811;4108.075682971307;4113.341865301597;4116.238495878272;4121.670266378683;4121.814518346681;3785.9519170224185;3881.592432794516;4185.958140418617;4189.224993376174;4191.958080419156;4469.307257375112;4580.862574122782;4613.19269127908;4621.6764826462495;4670.696404733681;5454.990826697073;5520.503154716095;5532.861678458071;5536.944630553723;5538.252335934678;1465.5310300703886;1479.0238442627815;1479.4304192885816;1482.4070371851346;1482.5700546841294;999.0459111548454;1011.1506334678905;1011.5245834457793;1019.5513973851481;1027.3887037212846;4972.651914366032;4977.054359671651;4983.053219888209;4983.750812459362;4988.501149884983;5856.648601083949;5860.062390017577;5862.765489380462;5873.383294754075;5875.148103524965;4956.628252881048;4960.404751429852;4968.180250258667;4970.627202959792;4971.37857767779;3099.5040793473386;3133.6709645487354;3158.9842050790057;3170.033139892355;3170.6670799565713;5600.5799565032785;5657.2928383952;5659.773609055592;5662.2639056922335;5667.518260947783;6086.847828804227;6090.665013424215;6092.208012958287;6095.390460953958;6097.939020609826;5517.310336207974;5642.858928526737;5648.181013752983;5650.943490565041;5657.60396772222;5919.852003699942;5923.526117910643;5930.843485520282;5930.940690593211;5933.970330148321;5699.401562835843;5751.798687045934;5754.424557544212;5754.4533269339345;5759.078547432391;5637.661740295432;5639.54883609302;5644.3508996465935;5647.3505546861;5650.830475085754;3911.882643520699;3973.463582416337;4004.899877503086;4015.2371049500503;4028.738132021409;5926.555508336805;5934.922777028006;5935;5938.2280303560265;5940.910886336622;5674.2623458950075;5693.686847223443;5699.572532060195;5701.686407247641;5703.030484817508;5554.02669392413;5656.943430565641;5664.320281566238;5694.601377903507;5696.344920334214;5557.5553955682635;5562.443755624405;5564.469770813059;5566.109422492382;5574.414686457863;5448.237246785374;5625.128105143709;5727.140928860705;5743.540516758733;5744.741486633028;5464.23500709893;5569.05326094573;5586.916196257141;5587.55299576041;5588.469095435927 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: |5;yui.html;641.0896526931758;648.6432462145818;662.9071929929811;779.9493032952861;793.5992323876442;11099.112071034318;11318.264312819661;11329.773404531914;11342.659720208396;11359.772804543903;10713.03582677559;11954.581589644364;12060.939695301511;12061.33662648554;12126.029917606593;804.4007214625112;821.5974172655416;822.62159406673;822.983540329193;823.1274848660439;806.2501873257868;814.0313027497289;816.0126247240846;816.147126253064;816.1797393619404;853.1042405474258;860.561113831944;861.4874149880811;861.6381119929645;862.017300277684;851.2721623012297;851.7189327521934;853.2960307746104;853.4751128056263;854.6453221912899;631.5105793010408;632.4023797511354;632.5919781740797;633.37612451735;633.5470138850698;10267.127294179929;10415.16678665705;10456.790864182674;10460.68617941463;10483.004114609175;9475.47884866332;9919.3056486046;10059.09468147863;10129.920342620913;10261.127804136657;8788.42875213109;8861.335399845037;8908.8663670045;8970.775730606721;8993.505357205351;3171.841407929617;3215.742740580748;3219.0986523773145;3231.8545665445113;3282.720968717662;33424.49863252053;33626;40179.39730904039;40284.7772178228;41768.582314176776;9124.17882390588;9291.860622090675;9384.202342800801;9508.144267016001;9732.70801875945;15452;15549.455769048256;15614.453494127878;15661.216939152997;15713.921430392775;6034.2155519782145;6162.291336496271;6204.100405441186;6252.906206406908;6277.905831412532;3528.2590655962535;3637.781733096023;3639.8544058237376;3646.5988741238443;3651.050726810995;2673.2782148820097;2675.304420850554;2693.7036925938132;2698.015224443064;2714.7285271472697;498.50647858619703;503.0592791479956;514.2902794144057;515.0188890164243;515.0780103614488;520.8958208358343;522.8457605006532;592.9940700592939;629.6883042893797;637.6684124255361;7176.390006849372;7582.696692132363;7711;7988.920110798934;8137.186281371934;563.9266895303584;591.6450129922098;615.1111643674936;623.9251289845157;628.7359309090193;3414.726821854246;3449.6032956209856;3499.2126771476214;3512.5433693619666;3683.686886614614;47663;47890.52109478861;48105.75947120312;48230.75884620554;52628.47371526236;40413.59586404098;40710.38934415986;40717.389239161435;42573.78713106477;47128;36053.639463605556;42527.574724252365;42614.36078458826;43408;43629.12741745211;7891.447598668038;7993.560354180343;8213.79465513367;8216.958915205385;8396.664133434839;32291.838540807144;32433.837830810695;32469.18827029343;32976.835115824266;33172.834135829165;34502.137446563036;35025.64974350326;43753.56246437495;44656.33015504835;45021.32468012917;9634.662786802708;9919.305648604528;10200;10314.742131446774;10690.41202733857;11551.42242887869;11692.35692036946;11729.824052639047;12077.57728479499;12310.569130080405;10468.319559228627;10702.946485267525;11065.557377704801;11114.16643751738;11275.267107637977;10456.790864182825;10954.233203675667;10991;11009.174311926798;11492.195546311677;10724.088452481314;10734.624288149877;10767.730806729895;10944.39805810688;10987.560497580327;9275.62897484093;9456;9590.664326748809;9747.951260243653;9753.170980466739;9312.906870931474;9854.21166306708;9863.802723945337;9876.209903207582;9881.950590247003 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: __startTimestamp1449075971726__endTimestamp 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:06:11 INFO - 2015-12-02 09:06:11,737 DEBUG : BROWSER_OUTPUT: 09:06:11 INFO - 2015-12-02 09:06:11,738 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4623.80 Median:4741.45 stddev:479.85 (10.1%) stddev-sans-first:455.00 09:06:11 INFO - 2015-12-02 09:06:11,738 DEBUG : BROWSER_OUTPUT: Values: 2625.5 2699.1 2706.2 2714.4 2720.3 4598.2 4650.4 4685.6 4685.8 4741.5 4581.3 4627.5 4695.4 4696.3 4709.2 4257.3 4290.1 4327.9 4346.5 4412.1 4222.3 4415.1 4426.9 4469.2 4472.9 4214.3 4285.0 4320.0 4325.4 4334.8 4314.1 4328.7 4331.1 4353.6 4368.5 4175.3 4286.1 4292.5 4296.2 4356.8 4505.9 4521.2 4540.9 4543.4 4546.6 4925.7 4947.6 5029.1 5057.6 5071.6 5067.9 5068.5 5069.3 5088.6 5098.9 4703.1 4703.5 4704.6 4710.6 4761.0 4948.9 5065.6 5066.8 5067.2 5068.6 4799.7 4876.0 4895.2 4915.6 4949.1 5076.7 5085.7 5114.2 5120.1 5120.3 5055.6 5058.7 5061.2 5062.2 5096.7 4780.7 4895.8 4897.0 4899.7 5001.0 4111.2 4143.6 4171.3 4177.1 4221.5 3657.0 3663.0 3669.6 3700.2 3705.0 4158.0 4248.1 4363.2 4367.3 4407.7 4843.9 4951.0 4980.8 5016.3 5039.6 4341.6 4342.3 4348.7 4350.0 4386.1 4280.6 4399.3 4454.3 4476.8 4503.1 4627.7 4687.7 4699.5 4702.8 4742.0 5026.0 5027.9 5028.5 5031.4 5073.5 4703.1 4801.0 4807.5 4814.0 4849.2 4873.0 4916.5 4917.4 4920.9 4945.0 5048.6 5076.9 5093.2 5095.1 5153.7 4686.4 4913.7 4917.7 4920.6 4970.1 4733.6 4851.1 4853.7 4865.6 4896.7 4746.7 4770.8 4775.5 4787.9 4825.5 4767.4 4928.3 4935.1 4937.2 4976.5 4700.6 4722.0 4742.2 4774.7 4783.4 09:06:11 INFO - 2015-12-02 09:06:11,738 DEBUG : BROWSER_OUTPUT: 09:06:11 INFO - 2015-12-02 09:06:11,738 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37546.75 Median:17878.34 stddev:56170.93 (314.2%) stddev-sans-first:56259.83 09:06:11 INFO - 2015-12-02 09:06:11,738 DEBUG : BROWSER_OUTPUT: Values: 553.9 570.2 577.2 581.4 588.6 26881.0 35494.1 36114.6 36197.8 36254.3 38539.8 38787.6 38825.4 38829.2 38960.4 6961.8 7111.8 7729.2 7860.1 7867.4 9962.2 10292.9 10320.5 10324.6 10333.8 9998.1 10078.3 10081.1 10099.4 10105.5 7190.2 7371.0 9699.7 9840.5 10021.6 9562.5 9774.4 9776.9 9780.2 9782.2 33780.7 34253.1 34323.8 34361.8 34487.0 2856.0 2861.4 2864.8 3064.0 3365.8 28159.7 28184.7 28288.7 28398.3 28533.1 3167.7 3254.8 3260.6 3269.2 3300.6 209595.0 211584.0 211614.0 212459.0 212731.0 49925.5 50494.0 50766.7 53817.5 54362.0 46272.0 47525.8 48072.5 48279.3 48349.0 14052.8 14150.7 14260.4 14276.1 14279.1 10693.3 10750.1 10755.7 10757.6 10765.6 18651.3 18717.4 18727.5 18897.2 18918.8 7199.2 7511.5 7543.1 7557.3 7607.2 878.6 888.3 909.2 910.3 984.3 25441.2 25675.9 26100.0 26535.0 26558.9 948.6 972.8 986.6 986.8 993.3 13633.0 14094.2 14323.0 14422.4 15617.8 253592.0 256317.0 256559.0 257699.0 258339.0 45593.0 45670.8 45826.3 45877.3 45912.3 1201.8 1204.9 1211.2 1212.2 1224.9 26543.5 27173.2 27316.7 27396.6 27489.6 35619.1 36169.5 36241.3 42063.6 42998.4 173024.0 174363.0 174408.0 174714.0 174863.0 24290.5 24708.8 25959.4 26280.1 26337.3 36446.6 37113.0 37361.8 37948.8 38258.0 31140.5 32439.7 33371.0 33735.3 34126.5 32375.5 32399.0 32438.2 32501.8 32821.7 32728.3 33074.8 33135.0 33176.2 33252.2 28427.0 29510.4 29934.0 30231.2 30449.7 22984.8 23227.9 23433.3 23700.8 23774.6 09:06:11 INFO - 2015-12-02 09:06:11,738 DEBUG : BROWSER_OUTPUT: 09:06:11 INFO - 2015-12-02 09:06:11,738 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27958.95 Median:2135.34 stddev:84025.48 (3935.0%) stddev-sans-first:84235.58 09:06:11 INFO - 2015-12-02 09:06:11,739 DEBUG : BROWSER_OUTPUT: Values: 330.8 332.6 332.7 334.4 338.6 12458.1 12885.6 14922.1 15313.1 15940.2 12162.3 15507.6 15943.8 16296.2 16496.5 5459.4 5479.2 5589.9 5635.2 5638.2 3886.5 4038.9 5560.3 5614.2 6496.8 6570.1 6628.8 6639.8 6662.5 6663.7 6398.2 6549.3 6564.1 6571.2 6573.6 6128.0 6211.7 6259.5 6273.9 6326.3 19998.6 20640.7 20723.4 20885.4 21647.5 1966.6 1994.2 2006.7 2081.0 2105.5 13736.4 13884.7 14062.4 14091.4 14158.7 1836.7 1895.2 2055.0 2177.8 2191.8 60539.4 64161.4 64563.4 65020.3 65227.7 15497.8 15596.2 15616.7 15772.1 15777.4 23487.4 23637.5 23819.4 23820.0 23822.5 8756.8 8843.7 8856.3 8909.7 8930.8 7327.5 7340.1 7356.6 7382.9 7399.2 7524.7 7620.2 7657.5 7669.7 7807.6 1704.3 1709.1 1716.5 2133.7 3122.6 364.5 365.2 384.1 400.4 842.8 9160.4 9849.2 13432.9 15125.8 15576.5 835.1 839.5 868.0 925.3 934.0 8666.5 8966.8 9083.3 9130.3 9278.2 504628.0 509253.0 514399.0 523138.0 523365.0 69239.7 69449.7 71072.6 71454.3 71519.3 1077.8 1083.1 1084.7 1101.0 1104.2 14352.4 14407.1 14486.6 14591.2 14656.3 29512.9 29993.0 30028.5 30299.2 31280.0 41872.0 42883.4 45640.8 46780.5 47016.5 8109.4 8664.5 8670.5 8676.1 8676.7 9744.7 9810.3 12302.6 15442.3 15799.4 13049.2 13603.7 13608.1 13763.7 13764.9 13008.5 13413.6 13463.9 13597.8 13836.6 10551.5 10621.6 13153.4 13249.8 13700.5 7964.2 8005.6 8009.6 8018.5 8827.6 8558.5 8590.9 8624.7 13566.7 14081.2 09:06:11 INFO - 2015-12-02 09:06:11,739 DEBUG : BROWSER_OUTPUT: 09:06:11 INFO - 2015-12-02 09:06:11,740 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4961.30 Median:6156.32 stddev:2557.23 (41.5%) stddev-sans-first:2549.24 09:06:11 INFO - 2015-12-02 09:06:11,740 DEBUG : BROWSER_OUTPUT: Values: 1256.5 1467.9 1508.0 1615.7 1725.7 6082.3 6914.6 7062.1 7065.9 7067.1 7116.0 7291.5 7298.4 7309.3 7316.2 2064.4 2112.9 2113.3 2114.1 2114.6 2054.1 2060.1 2082.3 2082.4 2084.5 1987.5 2023.8 2044.0 2049.0 2051.5 2070.6 2087.8 2089.2 2090.6 2094.0 2041.4 2076.3 2076.7 2094.2 2097.9 5982.1 6123.2 7054.0 7192.9 7193.6 4002.5 4104.4 4130.6 4154.8 4158.6 2654.7 2685.2 2713.3 2716.4 2727.9 798.0 799.8 1682.2 1685.7 1709.3 9091.4 9247.1 9261.6 9267.5 9282.9 3716.3 3745.6 3789.3 3803.8 3839.0 7858.1 7867.2 7886.6 7894.7 7901.9 4176.0 4177.4 4195.1 4195.9 4206.9 3856.5 3860.5 3874.1 3881.7 3887.8 3071.9 3087.5 3095.1 3105.8 3128.6 903.1 906.7 912.8 923.2 924.0 907.4 1186.1 1188.8 1194.3 1219.1 6741.6 6770.3 6791.7 6794.2 6801.4 436.1 437.1 438.6 1108.6 1138.0 5325.1 5413.4 5442.4 5482.1 5493.6 8441.5 8511.7 8554.3 8581.5 8649.0 8327.6 8397.9 8440.1 8491.3 8520.7 6721.5 6850.1 6902.3 6907.8 6911.0 6745.4 6776.9 6827.2 6864.7 6869.9 7563.5 7731.7 7768.3 7800.6 7824.9 7884.4 7893.4 7974.1 7992.0 8020.0 6264.3 6308.5 6338.2 6350.6 6386.8 6778.0 6896.1 6898.6 6920.9 6927.7 6052.8 6117.9 6171.7 6266.6 6465.0 6368.6 6480.5 6526.6 6571.5 6604.5 6579.4 6629.0 6630.0 6641.5 6643.4 5778.5 6053.6 6055.5 6140.9 6208.3 5516.8 5705.3 5792.3 5930.0 5931.2 09:06:11 INFO - 2015-12-02 09:06:11,740 DEBUG : BROWSER_OUTPUT: 09:06:11 INFO - 2015-12-02 09:06:11,740 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4699.11 Median:5317.34 stddev:1386.47 (26.1%) stddev-sans-first:1350.27 09:06:11 INFO - 2015-12-02 09:06:11,740 DEBUG : BROWSER_OUTPUT: Values: 289.2 296.3 300.3 303.9 304.5 5296.1 5296.9 5337.7 5488.8 5527.6 5337.9 5384.0 5402.1 5406.1 5413.5 3949.6 4146.1 4151.2 4159.4 4164.9 4009.1 4099.3 4134.6 4152.9 4164.2 4098.3 4117.2 4122.0 4140.3 4165.0 3956.1 4036.0 4059.3 4169.9 4173.8 3656.2 3660.1 3664.2 3679.5 3688.4 5174.2 5183.7 5187.2 5188.4 5199.5 4786.2 4792.0 4796.4 4798.3 4800.4 5507.1 5637.9 5641.1 5644.6 5647.7 4002.3 4003.8 4004.6 4005.4 4006.6 5860.1 5945.5 5950.5 5951.6 5952.2 4108.1 4113.3 4116.2 4121.7 4121.8 3786.0 3881.6 4186.0 4189.2 4192.0 4469.3 4580.9 4613.2 4621.7 4670.7 5455.0 5520.5 5532.9 5536.9 5538.3 1465.5 1479.0 1479.4 1482.4 1482.6 999.0 1011.2 1011.5 1019.6 1027.4 4972.7 4977.1 4983.1 4983.8 4988.5 5856.6 5860.1 5862.8 5873.4 5875.1 4956.6 4960.4 4968.2 4970.6 4971.4 3099.5 3133.7 3159.0 3170.0 3170.7 5600.6 5657.3 5659.8 5662.3 5667.5 6086.8 6090.7 6092.2 6095.4 6097.9 5517.3 5642.9 5648.2 5650.9 5657.6 5919.9 5923.5 5930.8 5930.9 5934.0 5699.4 5751.8 5754.4 5754.5 5759.1 5637.7 5639.5 5644.4 5647.4 5650.8 3911.9 3973.5 4004.9 4015.2 4028.7 5926.6 5934.9 5935.0 5938.2 5940.9 5674.3 5693.7 5699.6 5701.7 5703.0 5554.0 5656.9 5664.3 5694.6 5696.3 5557.6 5562.4 5564.5 5566.1 5574.4 5448.2 5625.1 5727.1 5743.5 5744.7 5464.2 5569.1 5586.9 5587.6 5588.5 09:06:11 INFO - 2015-12-02 09:06:11,740 DEBUG : BROWSER_OUTPUT: 09:06:11 INFO - 2015-12-02 09:06:11,741 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12136.22 Median:47395.50 stddev:13682.05 (28.9%) stddev-sans-first:13693.19 09:06:11 INFO - 2015-12-02 09:06:11,741 DEBUG : BROWSER_OUTPUT: Values: 641.1 648.6 662.9 779.9 793.6 11099.1 11318.3 11329.8 11342.7 11359.8 10713.0 11954.6 12060.9 12061.3 12126.0 804.4 821.6 822.6 823.0 823.1 806.3 814.0 816.0 816.1 816.2 853.1 860.6 861.5 861.6 862.0 851.3 851.7 853.3 853.5 854.6 631.5 632.4 632.6 633.4 633.5 10267.1 10415.2 10456.8 10460.7 10483.0 9475.5 9919.3 10059.1 10129.9 10261.1 8788.4 8861.3 8908.9 8970.8 8993.5 3171.8 3215.7 3219.1 3231.9 3282.7 33424.5 33626.0 40179.4 40284.8 41768.6 9124.2 9291.9 9384.2 9508.1 9732.7 15452.0 15549.5 15614.5 15661.2 15713.9 6034.2 6162.3 6204.1 6252.9 6277.9 3528.3 3637.8 3639.9 3646.6 3651.1 2673.3 2675.3 2693.7 2698.0 2714.7 498.5 503.1 514.3 515.0 515.1 520.9 522.8 593.0 629.7 637.7 7176.4 7582.7 7711.0 7988.9 8137.2 563.9 591.6 615.1 623.9 628.7 3414.7 3449.6 3499.2 3512.5 3683.7 47663.0 47890.5 48105.8 48230.8 52628.5 40413.6 40710.4 40717.4 42573.8 47128.0 36053.6 42527.6 42614.4 43408.0 43629.1 7891.4 7993.6 8213.8 8217.0 8396.7 32291.8 32433.8 32469.2 32976.8 33172.8 34502.1 35025.6 43753.6 44656.3 45021.3 9634.7 9919.3 10200.0 10314.7 10690.4 11551.4 11692.4 11729.8 12077.6 12310.6 10468.3 10702.9 11065.6 11114.2 11275.3 10456.8 10954.2 10991.0 11009.2 11492.2 10724.1 10734.6 10767.7 10944.4 10987.6 9275.6 9456.0 9590.7 9748.0 9753.2 9312.9 9854.2 9863.8 9876.2 9882.0 09:06:11 INFO - 2015-12-02 09:06:11,741 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:06:11 INFO - 2015-12-02 09:06:11,742 DEBUG : BROWSER_OUTPUT: 09:06:12 INFO - 2015-12-02 09:06:12,513 INFO : Browser exited with error code: 0 09:06:12 INFO - 2015-12-02 09:06:12,532 INFO : Completed test dromaeo_css (00:18:37) 09:06:12 INFO - 2015-12-02 09:06:12,532 INFO : Starting test kraken 09:06:12 INFO - 2015-12-02 09:06:12,532 DEBUG : operating with platform_type : linux_ 09:06:12 INFO - 2015-12-02 09:06:12,532 INFO : Initialising browser for kraken test... 09:06:12 INFO - 2015-12-02 09:06:12,538 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpamfRk9/profile http://localhost:43404/getInfo.html 09:06:16 INFO - 2015-12-02 09:06:16,574 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:06:16 INFO - 2015-12-02 09:06:16,574 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:06:16 INFO - 2015-12-02 09:06:16,574 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:06:16 INFO - 2015-12-02 09:06:16,574 DEBUG : BROWSER_OUTPUT: __metrics 09:06:16 INFO - 2015-12-02 09:06:16,650 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] 09:06:16 INFO - 2015-12-02 09:06:16,651 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:17 INFO - 2015-12-02 09:06:17,543 INFO : Browser initialized. 09:06:17 INFO - 2015-12-02 09:06:17,543 INFO : Running cycle 1/1 for kraken test... 09:06:17 INFO - 2015-12-02 09:06:17,544 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpamfRk9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:06:29 INFO - 2015-12-02 09:06:29,545 DEBUG : BROWSER_OUTPUT: RSS: Main: 143544320 09:06:29 INFO - 2015-12-02 09:06:29,545 DEBUG : BROWSER_OUTPUT: 09:06:32 INFO - 2015-12-02 09:06:32,160 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43404/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:32 INFO - 2015-12-02 09:06:32,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 183033856 09:06:32 INFO - 2015-12-02 09:06:32,741 DEBUG : BROWSER_OUTPUT: 09:06:35 INFO - 2015-12-02 09:06:35,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43404/tests/kraken/driver.html?testName=audio-dft) 09:06:36 INFO - 2015-12-02 09:06:36,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 171601920 09:06:36 INFO - 2015-12-02 09:06:36,036 DEBUG : BROWSER_OUTPUT: 09:06:39 INFO - 2015-12-02 09:06:39,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43404/tests/kraken/driver.html?testName=audio-fft) 09:06:39 INFO - 2015-12-02 09:06:39,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 153640960 09:06:39 INFO - 2015-12-02 09:06:39,647 DEBUG : BROWSER_OUTPUT: 09:06:41 INFO - 2015-12-02 09:06:41,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43404/tests/kraken/driver.html?testName=audio-oscillator) 09:06:42 INFO - 2015-12-02 09:06:42,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 156745728 09:06:42 INFO - 2015-12-02 09:06:42,266 DEBUG : BROWSER_OUTPUT: 09:06:44 INFO - 2015-12-02 09:06:44,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:45 INFO - 2015-12-02 09:06:45,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 157454336 09:06:45 INFO - 2015-12-02 09:06:45,090 DEBUG : BROWSER_OUTPUT: 09:06:48 INFO - 2015-12-02 09:06:48,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43404/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:48 INFO - 2015-12-02 09:06:48,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 157417472 09:06:48 INFO - 2015-12-02 09:06:48,701 DEBUG : BROWSER_OUTPUT: 09:06:52 INFO - 2015-12-02 09:06:52,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43404/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:52 INFO - 2015-12-02 09:06:52,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 159555584 09:06:52 INFO - 2015-12-02 09:06:52,665 DEBUG : BROWSER_OUTPUT: 09:06:55 INFO - 2015-12-02 09:06:55,502 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43404/tests/kraken/driver.html?testName=json-parse-financial) 09:06:56 INFO - 2015-12-02 09:06:56,075 DEBUG : BROWSER_OUTPUT: RSS: Main: 157761536 09:06:56 INFO - 2015-12-02 09:06:56,075 DEBUG : BROWSER_OUTPUT: 09:06:57 INFO - 2015-12-02 09:06:57,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:58 INFO - 2015-12-02 09:06:58,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 168378368 09:06:58 INFO - 2015-12-02 09:06:58,460 DEBUG : BROWSER_OUTPUT: 09:07:00 INFO - 2015-12-02 09:07:00,375 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43404/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:07:00 INFO - 2015-12-02 09:07:00,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 169279488 09:07:00 INFO - 2015-12-02 09:07:00,977 DEBUG : BROWSER_OUTPUT: 09:07:03 INFO - 2015-12-02 09:07:03,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:07:03 INFO - 2015-12-02 09:07:03,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 182403072 09:07:03 INFO - 2015-12-02 09:07:03,695 DEBUG : BROWSER_OUTPUT: 09:07:06 INFO - 2015-12-02 09:07:06,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:06 INFO - 2015-12-02 09:07:06,797 DEBUG : BROWSER_OUTPUT: RSS: Main: 184180736 09:07:06 INFO - 2015-12-02 09:07:06,798 DEBUG : BROWSER_OUTPUT: 09:07:09 INFO - 2015-12-02 09:07:09,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:09 INFO - 2015-12-02 09:07:09,994 DEBUG : BROWSER_OUTPUT: RSS: Main: 183898112 09:07:09 INFO - 2015-12-02 09:07:09,994 DEBUG : BROWSER_OUTPUT: 09:07:11 INFO - 2015-12-02 09:07:11,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43404/tests/kraken/driver.html?testName=ai-astar) 09:07:12 INFO - 2015-12-02 09:07:12,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 240672768 09:07:12 INFO - 2015-12-02 09:07:12,006 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,006 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:07:12 INFO - 2015-12-02 09:07:12,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:07:12 INFO - 2015-12-02 09:07:12,006 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:07:12 INFO - 2015-12-02 09:07:12,006 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:07:12 INFO - 2015-12-02 09:07:12,007 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;110;103;110;109;110;98;108;110;104 09:07:12 INFO - 2015-12-02 09:07:12,007 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;128;162;168;138;156;153;129;165;133 09:07:12 INFO - 2015-12-02 09:07:12,007 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;160;161;161;160;161;162;162;161;162 09:07:12 INFO - 2015-12-02 09:07:12,007 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;87;90;72;71;72;98;89;73 09:07:12 INFO - 2015-12-02 09:07:12,007 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;135;93;94;94;129;93;94;132 09:07:12 INFO - 2015-12-02 09:07:12,007 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;109;109;109;110 09:07:12 INFO - 2015-12-02 09:07:12,007 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;147;146;147;146;147;147;147 09:07:12 INFO - 2015-12-02 09:07:12,008 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;95;96;96;96 09:07:12 INFO - 2015-12-02 09:07:12,008 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;70;72;71;70;71;71;83;69;70 09:07:12 INFO - 2015-12-02 09:07:12,008 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;68;69;69;69;69;69;68 09:07:12 INFO - 2015-12-02 09:07:12,008 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;82;83;91;82;85;85;84;84 09:07:12 INFO - 2015-12-02 09:07:12,008 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;117;125;122;125;118;129;120;118;135 09:07:12 INFO - 2015-12-02 09:07:12,008 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;148;148;148;155;146;145;145;147;136 09:07:12 INFO - 2015-12-02 09:07:12,008 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;69;68;67;68;67;66;67;67;67 09:07:12 INFO - 2015-12-02 09:07:12,009 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:07:12 INFO - 2015-12-02 09:07:12,009 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:07:12 INFO - 2015-12-02 09:07:12,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 09:07:12 INFO - 2015-12-02 09:07:12,009 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:07:12 INFO - 2015-12-02 09:07:12,009 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076032000__endTimestamp 09:07:12 INFO - 2015-12-02 09:07:12,009 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,009 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:07:12 INFO - 2015-12-02 09:07:12,009 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.00 Median:110.00 stddev:4.06 (3.7%) stddev-sans-first:4.28 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: Values: 108.0 110.0 103.0 110.0 109.0 110.0 98.0 108.0 110.0 104.0 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.30 Median:154.50 stddev:15.16 (9.8%) stddev-sans-first:16.05 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: Values: 151.0 128.0 162.0 168.0 138.0 156.0 153.0 129.0 165.0 133.0 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.43 (0.9%) stddev-sans-first:0.78 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: Values: 165.0 160.0 161.0 161.0 160.0 161.0 162.0 162.0 161.0 162.0 09:07:12 INFO - 2015-12-02 09:07:12,010 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.70 Median:80.00 stddev:10.13 (12.7%) stddev-sans-first:10.36 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 87.0 90.0 72.0 71.0 72.0 98.0 89.0 73.0 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:93.50 stddev:18.62 (19.9%) stddev-sans-first:19.23 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 135.0 93.0 94.0 94.0 129.0 93.0 94.0 132.0 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,012 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:71.00 stddev:4.01 (5.7%) stddev-sans-first:4.26 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: Values: 72.0 70.0 72.0 71.0 70.0 71.0 71.0 83.0 69.0 70.0 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 68.0 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:2.75 (3.3%) stddev-sans-first:2.82 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 82.0 83.0 91.0 82.0 85.0 85.0 84.0 84.0 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:123.50 stddev:5.70 (4.6%) stddev-sans-first:5.95 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: Values: 120.0 117.0 125.0 122.0 125.0 118.0 129.0 120.0 118.0 135.0 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:147.50 stddev:4.65 (3.2%) stddev-sans-first:4.93 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 148.0 148.0 155.0 146.0 145.0 145.0 147.0 136.0 09:07:12 INFO - 2015-12-02 09:07:12,013 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,014 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 09:07:12 INFO - 2015-12-02 09:07:12,014 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 67.0 68.0 67.0 66.0 67.0 67.0 67.0 09:07:12 INFO - 2015-12-02 09:07:12,014 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:07:12 INFO - 2015-12-02 09:07:12,014 DEBUG : BROWSER_OUTPUT: 09:07:12 INFO - 2015-12-02 09:07:12,933 INFO : Browser exited with error code: 0 09:07:12 INFO - 2015-12-02 09:07:12,984 INFO : Completed test kraken (00:01:00) 09:07:12 INFO - 2015-12-02 09:07:12,984 INFO : Starting test v8_7 09:07:12 INFO - 2015-12-02 09:07:12,984 DEBUG : operating with platform_type : linux_ 09:07:12 INFO - 2015-12-02 09:07:12,985 INFO : Initialising browser for v8_7 test... 09:07:12 INFO - 2015-12-02 09:07:12,991 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq46xpM/profile http://localhost:43404/getInfo.html 09:07:16 INFO - 2015-12-02 09:07:16,724 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:07:16 INFO - 2015-12-02 09:07:16,724 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:07:16 INFO - 2015-12-02 09:07:16,725 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:07:16 INFO - 2015-12-02 09:07:16,725 DEBUG : BROWSER_OUTPUT: __metrics 09:07:16 INFO - 2015-12-02 09:07:16,862 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] 09:07:16 INFO - 2015-12-02 09:07:16,862 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:17 INFO - 2015-12-02 09:07:17,996 INFO : Browser initialized. 09:07:17 INFO - 2015-12-02 09:07:17,996 INFO : Running cycle 1/1 for v8_7 test... 09:07:17 INFO - 2015-12-02 09:07:17,996 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq46xpM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:07:29 INFO - 2015-12-02 09:07:29,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 143388672 09:07:29 INFO - 2015-12-02 09:07:29,955 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43404/tests/v8_7/run.html (next: http://localhost:43404/tests/v8_7/run.html) 09:07:51 INFO - 2015-12-02 09:07:51,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 447676416 09:07:51 INFO - 2015-12-02 09:07:51,691 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,691 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:07:51 INFO - 2015-12-02 09:07:51,691 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:07:51 INFO - 2015-12-02 09:07:51,692 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:07:51 INFO - 2015-12-02 09:07:51,692 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:07:51 INFO - 2015-12-02 09:07:51,692 DEBUG : BROWSER_OUTPUT: |0;Richards;166.66666666666666 09:07:51 INFO - 2015-12-02 09:07:51,692 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.42555164101614 09:07:51 INFO - 2015-12-02 09:07:51,692 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.6420581655481 09:07:51 INFO - 2015-12-02 09:07:51,692 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 09:07:51 INFO - 2015-12-02 09:07:51,693 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2002 09:07:51 INFO - 2015-12-02 09:07:51,693 DEBUG : BROWSER_OUTPUT: |5;Earley;779.423226812159 09:07:51 INFO - 2015-12-02 09:07:51,693 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 09:07:51 INFO - 2015-12-02 09:07:51,693 DEBUG : BROWSER_OUTPUT: |7;RegExp;26256.410256410258 09:07:51 INFO - 2015-12-02 09:07:51,693 DEBUG : BROWSER_OUTPUT: |8;Splay;624.0648379052369 09:07:51 INFO - 2015-12-02 09:07:51,693 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 09:07:51 INFO - 2015-12-02 09:07:51,693 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:07:51 INFO - 2015-12-02 09:07:51,693 DEBUG : BROWSER_OUTPUT: __startTimestamp1449076071689__endTimestamp 09:07:51 INFO - 2015-12-02 09:07:51,693 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.67 Median:166.67 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: Values: 166.7 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.43 Median:185.43 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: Values: 185.4 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.64 Median:279.64 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,694 DEBUG : BROWSER_OUTPUT: Values: 279.6 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: Values: 5133.3 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2002.00 Median:2002.00 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: Values: 2002.0 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:779.42 Median:779.42 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: Values: 779.4 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: Values: 12096.4 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: Values: 26256.4 09:07:51 INFO - 2015-12-02 09:07:51,695 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,696 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:624.06 Median:624.06 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,696 DEBUG : BROWSER_OUTPUT: Values: 624.1 09:07:51 INFO - 2015-12-02 09:07:51,696 DEBUG : BROWSER_OUTPUT: 09:07:51 INFO - 2015-12-02 09:07:51,696 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 09:07:51 INFO - 2015-12-02 09:07:51,696 DEBUG : BROWSER_OUTPUT: Values: 4840.6 09:07:51 INFO - 2015-12-02 09:07:51,696 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:07:51 INFO - 2015-12-02 09:07:51,696 DEBUG : BROWSER_OUTPUT: 09:07:52 INFO - 2015-12-02 09:07:52,621 INFO : Browser exited with error code: 0 09:07:52 INFO - 2015-12-02 09:07:52,633 INFO : Completed test v8_7 (00:00:39) 09:07:52 INFO - 2015-12-02 09:07:52,634 INFO : Completed test suite (00:20:17) 09:07:52 INFO - 2015-12-02 09:07:52,635 DEBUG : Working with test: dromaeo_css 09:07:52 INFO - 2015-12-02 09:07:52,635 DEBUG : Generating results file: dromaeo_css 09:07:52 INFO - 2015-12-02 09:07:52,636 DEBUG : Working with test: kraken 09:07:52 INFO - 2015-12-02 09:07:52,636 DEBUG : Generating results file: kraken 09:07:52 INFO - 2015-12-02 09:07:52,636 INFO : javascript benchmark 09:07:52 INFO - 2015-12-02 09:07:52,636 DEBUG : Working with test: v8_7 09:07:52 INFO - 2015-12-02 09:07:52,637 DEBUG : Generating results file: v8_7 09:07:52 INFO - 2015-12-02 09:07:52,637 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:07:52 INFO - 2015-12-02 09:07:52,700 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:07:52 INFO - 2015-12-02 09:07:52,700 DEBUG : process_Request line: dromaeo_css 6382.88 graph.html#tests=[[72,132,35]] 09:07:52 INFO - 2015-12-02 09:07:52,700 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:07:52 INFO - 2015-12-02 09:07:52,736 DEBUG : process_Request line: kraken 1514.80 graph.html#tests=[[232,132,35]] 09:07:52 INFO - 2015-12-02 09:07:52,736 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:07:52 INFO - 2015-12-02 09:07:52,769 DEBUG : process_Request line: v8_7 19823.26 graph.html#tests=[[230,132,35]] 09:07:52 INFO - 2015-12-02 09:07:52,770 INFO : javascript benchmark 09:07:52 INFO - 2015-12-02 09:07:52,774 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2625.527405067088, 2699.122785094845, 2706.215197592698, 2714.362124900648, 2720.251930719053, 4598.241290187124, 4650.441946966364, 4685.64857635677, 4685.8125674973, 4741.45473270574, 4581.335706322589, 4627.537246275371, 4695.366125573047, 4696.342512048307, 4709.2229782086, 4257.276263035284, 4290.141971605676, 4327.913441731163, 4346.5436129206455, 4412.0955204183065, 4222.324428091506, 4415.116976604692, 4426.933595996063, 4469.173202957447, 4472.9329060063965, 4214.283571792803, 4284.978575107105, 4319.978400108011, 4325.394444777718, 4334.783260836945, 4314.115606300701, 4328.696991210617, 4331.06882020364, 4353.62994145498, 4368.475782906072, 4175.31107367284, 4286.057067445188, 4292.484901811771, 4296.226679197744, 4356.8257269709175, 4505.932411013805, 4521.208788462006, 4540.931886021713, 4543.40935678363, 4546.568076032805, 4925.704457732511, 4947.628927830391, 5029.145045342264, 5057.5701065409485, 5071.594272458195, 5067.873303167414, 5068.493150684939, 5069.315642388267, 5088.592912566985, 5098.949010509885, 4703.129920964564, 4703.45910220329, 4704.5765881070865, 4710.5760481556135, 4760.952390476085, 4948.925766113512, 5065.620078494054, 5066.797328106908, 5067.189249720027, 5068.594512438996, 4799.66402351839, 4875.95124048762, 4895.192293271571, 4915.582175515121, 4949.059678661043, 5076.720780357042, 5085.694858308513, 5114.232865070269, 5120.078385890575, 5120.334356533701, 5055.646104772704, 5058.721770302595, 5061.215511595708, 5062.190049592047, 5096.745162741848, 4780.665353425296, 4895.779689913962, 4896.975515122473, 4899.730514821719, 5001.0, 4111.157212771374, 4143.56492568282, 4171.290880550314, 4177.081042170717, 4221.472315960505, 3656.981715091461, 3663.0, 3669.559652841676, 3700.2229531798084, 3705.0181701849033, 4157.958420415757, 4248.065425606362, 4363.214621368121, 4367.344898265222, 4407.6914615976575, 4843.903121937541, 4951.0, 4980.77586508608, 5016.347874776256, 5039.596832253411, 4341.60925516705, 4342.261815491374, 4348.695591308578, 4350.0, 4386.122775444924, 4280.614744672995, 4399.340098985178, 4454.28731402974, 4476.753778542212, 4503.144402563503, 4627.745473998895, 4687.67186296956, 4699.459562150397, 4702.76486175683, 4742.004179122285, 5025.974870125626, 5027.949720502895, 5028.497150284942, 5031.4213865405945, 5073.492650735045, 4703.059388122458, 4800.975995120002, 4807.495213002724, 4814.037192561572, 4849.248366503198, 4872.975635121802, 4916.459189489082, 4917.385326834145, 4920.8682003138765, 4944.950550494593, 5048.59611231108, 5076.873078173076, 5093.23601459784, 5095.0574143783515, 5153.665011774223, 4686.437627484724, 4913.680610760289, 4917.704937703749, 4920.581750551243, 4970.130227210296, 4733.5503127202865, 4851.054044461296, 4853.708777473363, 4865.6107511398295, 4896.706197628154, 4746.691465054761, 4770.761461926959, 4775.5224477551965, 4787.928181077217, 4825.469198388104, 4767.427908650984, 4928.2607608857525, 4935.087008903364, 4937.21004639256, 4976.5023497649945, 4700.6474514410875, 4721.976390118028, 4742.217534106834, 4774.737389443614, 4783.378160839069], "unit": "ms", "name": "dojo.html", "value": 4594.134228408004}, {"lowerIsBetter": false, "replicates": [553.9208862734181, 570.2102587915738, 577.2236342119847, 581.3895409819689, 588.5938702295416, 26881.0, 35494.112647183836, 36114.638853611454, 36197.81901090491, 36254.27491450176, 38539.807300963526, 38787.61212387875, 38825.41761873567, 38829.22341553167, 38960.41559376611, 6961.756338528153, 7111.8222044448785, 7729.188435214306, 7860.0960889497865, 7867.409944254176, 9962.203023758118, 10292.948535257314, 10320.483975801217, 10324.638637647684, 10333.844992325121, 9998.05018523239, 10078.34490758102, 10081.09270165685, 10099.394036357842, 10105.54525046371, 7190.173130090028, 7371.041764570571, 9699.66051188212, 9840.507974601278, 10021.649242276486, 9562.521873906346, 9774.413535187912, 9776.90223097767, 9780.217582593375, 9782.168515676176, 33780.662193378, 34253.143671408165, 34323.828380858184, 34361.82819085914, 34487.0, 2855.957160642592, 2861.399106187703, 2864.799464037518, 3064.0195137555993, 3365.7643964922463, 28159.718402815914, 28184.71815281862, 28288.717112828814, 28398.29004274889, 28533.144005679864, 3167.683231676837, 3254.8372581370836, 3260.559824423696, 3269.2317305433203, 3300.624885222624, 209595.0, 211584.0, 211614.0, 212459.0, 212731.0, 49925.50074499209, 50494.0, 50766.74616626967, 53817.46182538203, 54362.0, 46272.0, 47525.76237118861, 48072.519274807506, 48279.27581086286, 48349.0, 14052.789208161887, 14150.716985660434, 14260.42958281657, 14276.14343139415, 14279.071860329046, 10693.251472397013, 10750.086242669304, 10755.677329680122, 10757.56969721218, 10765.623203187852, 18651.253949841856, 18717.438476845717, 18727.531811704543, 18897.24411023571, 18918.81081189198, 7199.172095209014, 7511.49770045993, 7543.057117860268, 7557.319841214317, 7607.201243869425, 878.6221924572368, 888.3159966825508, 909.2362415570819, 910.2990697163148, 984.2913102566141, 25441.236762897144, 25675.871620641778, 26100.0, 26535.0, 26558.86720566385, 948.5873644964324, 972.7616733900239, 986.556049777603, 986.7631768375538, 993.3245393132739, 13633.0, 14094.154350738989, 14323.0, 14422.350994205286, 15617.843821561866, 253592.0, 256317.0, 256559.0, 257699.0, 258339.0, 45593.0, 45670.771646142224, 45826.312605310944, 45877.31184032242, 45912.3113153303, 1201.7896868048056, 1204.9216800907914, 1211.236920739928, 1212.2423485321674, 1224.8591411987736, 26543.469130617665, 27173.184804455897, 27316.726832732213, 27396.58905116385, 27489.587656185573, 35619.10952226111, 36169.45745813762, 36241.27517449689, 42063.579364205965, 42998.35502467528, 173024.0, 174363.0, 174408.0, 174714.0, 174863.0, 24290.54256744601, 24708.752912470645, 25959.351016224744, 26280.080197193005, 26337.28807627498, 36446.63553364432, 37113.0, 37361.81319093387, 37948.81025594854, 38258.0435489115, 31140.53289200709, 32439.675603243664, 33371.0, 33735.32529349448, 34126.488102677984, 32375.51436728498, 32399.0, 32438.189045274055, 32501.837490812395, 32821.67178328186, 32728.34543309168, 33074.83462582768, 33135.0, 33176.1705957353, 33252.16869578183, 28427.0, 29510.40979180447, 29934.0, 30231.244218894702, 30449.695503045572, 22984.770152298934, 23227.88386058059, 23433.297001089995, 23700.762992369855, 23774.643380349655], "unit": "ms", "name": "ext.html", "value": 16730.82222005535}, {"lowerIsBetter": false, "replicates": [330.7563561010601, 332.6424094098843, 332.7437872837914, 334.41644330643027, 338.629201024878, 12458.12793104483, 12885.613431597043, 14922.10467371957, 15313.081215127086, 15940.202989850519, 12162.27026378418, 15507.612309692264, 15943.760843587326, 16296.185190740445, 16496.505104846845, 5459.3994660587405, 5479.205515200293, 5589.944100558983, 5635.154726790973, 5638.238837756912, 3886.533615966088, 4038.899027524306, 5560.304961879765, 5614.157876318564, 6496.837579060514, 6570.080188773575, 6628.834279143036, 6639.8340041499105, 6662.533622646417, 6663.666816659172, 6398.2322121345505, 6549.34506549346, 6564.146660934096, 6571.178602674666, 6573.572717773353, 6127.988881834492, 6211.726596047799, 6259.499240060784, 6273.937260627381, 6326.272478664966, 19998.600027999357, 20640.69038964417, 20723.378298651063, 20885.37343879686, 21647.45881352963, 1966.5673551818577, 1994.1923520974028, 2006.7190593316948, 2080.9791902080938, 2105.5157313817754, 13736.381862816197, 13884.652883677887, 14062.437502499888, 14091.365888534938, 14158.716825663532, 1836.7153091270875, 1895.1566552883971, 2055.0, 2177.825773938081, 2191.824654027674, 60539.394606053815, 64161.358386416, 64563.3543664562, 65020.34979650143, 65227.673861630385, 15497.767533487007, 15596.220188990505, 15616.687666246611, 15772.132532710582, 15777.368905243662, 23487.41281467943, 23637.527249454914, 23819.404514887265, 23820.04719811223, 23822.545730869275, 8756.824863502694, 8843.734687959372, 8856.335774816915, 8909.73270801877, 8930.776730581658, 7327.523710958771, 7340.11918569775, 7356.558606483628, 7382.852342953111, 7399.223081576464, 7524.699012039567, 7620.161782203953, 7657.46397752152, 7669.693212271447, 7807.609619519001, 1704.250129942821, 1709.1454272863568, 1716.476474675211, 2133.743950725923, 3122.5628412022334, 364.54249916354803, 365.1710616899623, 384.1452767592141, 400.3894061556092, 842.7893026743315, 9160.358774885828, 9849.162821160138, 13432.865671343357, 15125.848741512664, 15576.45482408133, 835.1231207232381, 839.5088873009358, 867.9609417576224, 925.3383830561047, 933.9772948621248, 8666.523341216294, 8966.820663586823, 9083.273338132933, 9130.31522635805, 9278.164965153168, 504628.0, 509253.0, 514399.0, 523138.0, 523365.0, 69239.65380173067, 69449.65275173592, 71072.64463677649, 71454.2854571458, 71519.28480715126, 1077.8437126616755, 1083.101026148295, 1084.6529110684505, 1101.0382072225848, 1104.1773878460438, 14352.354144063751, 14407.135571865721, 14486.565403037926, 14591.176102987127, 14656.267186640413, 29512.852435738543, 29993.0, 30028.549571756004, 30299.242518937204, 31280.0, 41872.0, 42883.35674964941, 45640.771796140805, 46780.53219467762, 47016.529834701214, 8109.351251899716, 8664.523451210243, 8670.479771213748, 8676.132386761274, 8676.652933882826, 9744.658936937172, 9810.313278070467, 12302.569410070604, 15442.30509627047, 15799.447019354267, 13049.217046977212, 13603.659908502366, 13608.115472494255, 13763.655908601964, 13764.93117534406, 13008.544700935421, 13413.597592072254, 13463.932680336535, 13597.79603305971, 13836.584902452943, 10551.472426378803, 10621.575136994743, 13153.408096635865, 13249.80125298102, 13700.45198192061, 7964.2433968772875, 8005.599720014093, 8009.5995200238585, 8018.4787988780545, 8827.602757876039, 8558.49378443099, 8590.871136933076, 8624.741257762276, 13566.728665426834, 14081.225532595805], "unit": "ms", "name": "jquery.html", "value": 8862.529891569782}, {"lowerIsBetter": false, "replicates": [1256.4597223194023, 1467.8899082568807, 1508.0348576910776, 1615.6526346835435, 1725.670345034204, 6082.30053543842, 6914.619695916723, 7062.117235345582, 7065.940108983655, 7067.081279433679, 7116.039334689815, 7291.4895957283015, 7298.416126709863, 7309.305615966488, 7316.231795661445, 2064.3806857942595, 2112.8837913914726, 2113.3131732187026, 2114.1332053857923, 2114.608797372491, 2054.130870098832, 2060.072967164774, 2082.2816128435743, 2082.3648787119923, 2084.47888027993, 1987.4534503011644, 2023.7571491420977, 2044.0393015282793, 2049.047193055229, 2051.4871282179456, 2070.647989841723, 2087.8225350845196, 2089.185217765073, 2090.644590419625, 2093.9999999999923, 2041.3569725536556, 2076.345951025422, 2076.678114892194, 2094.2356040045424, 2097.8741275523516, 5982.132590774313, 6123.234595675541, 7054.0, 7192.856142877114, 7193.604351760651, 4002.4996875390575, 4104.42538044674, 4130.56629053948, 4154.792260386968, 4158.625723684852, 2654.681438227425, 2685.167598044593, 2713.308106432847, 2716.3888125171875, 2727.945441091167, 797.956112413817, 799.8320352725934, 1682.175733890385, 1685.7387104998745, 1709.2906443825798, 9091.363604547685, 9247.075292470767, 9261.583228754655, 9267.536623168815, 9282.90717092834, 3716.2567486502267, 3745.6441638044344, 3789.3368660484307, 3803.809809509569, 3838.9808050960123, 7858.1356050834365, 7867.173946735625, 7886.566238856918, 7894.684212631545, 7901.920980790233, 4175.97912010438, 4177.415161877339, 4195.139996300751, 4195.853145139967, 4206.85276015338, 3856.515241631992, 3860.478835357247, 3874.1476875087437, 3881.7476864003747, 3887.7667339959694, 3071.8617662205256, 3087.5368694695976, 3095.1178914009397, 3105.82917939511, 3128.6245650522083, 903.0969030969031, 906.71891713569, 912.7763697893926, 923.2198792020732, 924.0343840686498, 907.4419232172166, 1186.0807873897797, 1188.8335633011386, 1194.3496547893003, 1219.1465973818363, 6741.629210393377, 6770.32296770319, 6791.694373753094, 6794.150731158606, 6801.353871382211, 436.06681701159545, 437.0908510298571, 438.56143856143854, 1108.556577369059, 1137.9658610241706, 5325.068113080196, 5413.350397952192, 5442.374126975369, 5482.095454250004, 5493.560515158778, 8441.535715535581, 8511.702090426928, 8554.315654747605, 8581.528015959182, 8649.0, 8327.625256863455, 8397.874031889527, 8440.11378805229, 8491.278241349431, 8520.74437766868, 6721.495887808336, 6850.109485766819, 6902.344277293649, 6907.758228461979, 6911.03245545624, 6745.3591908768585, 6776.932230677828, 6827.180738311435, 6864.725410983705, 6869.896951545631, 7563.508371955805, 7731.690732370642, 7768.262015108556, 7800.648970796441, 7824.882626760717, 7884.448088633741, 7893.447458677838, 7974.122846486998, 7991.960040199761, 8020.0, 6264.34224406449, 6308.495320374267, 6338.207724034496, 6350.555461117678, 6386.776462823779, 6778.017187507685, 6896.103506544117, 6898.620575868375, 6920.861582768417, 6927.7228910843005, 6052.848678783065, 6117.877642447215, 6171.691415429121, 6266.561340706106, 6464.967675161594, 6368.64972426521, 6480.546361754632, 6526.641034743135, 6571.474282057519, 6604.537682362188, 6579.374959378852, 6629.0, 6630.0, 6641.535092543669, 6643.368879956396, 5778.451047150514, 6053.576249662481, 6055.515558755201, 6140.938590614215, 6208.255009398901, 5516.779328826802, 5705.343885453226, 5792.275965504312, 5929.970350148222, 5931.169636251015], "unit": "ms", "name": "mootools.html", "value": 4074.6308962386556}, {"lowerIsBetter": false, "replicates": [289.1960350226371, 296.25196379142665, 300.3032963524622, 303.90730827097724, 304.5188602008826, 5296.073187192245, 5296.947030529698, 5337.733113344337, 5488.835334939949, 5527.55779537637, 5337.946620533793, 5384.030874442608, 5402.081646120159, 5406.08096623574, 5413.458654134594, 3949.5852935441794, 4146.087860670647, 4151.211269858717, 4159.376093585956, 4164.937525937105, 4009.138035322405, 4099.262132816092, 4134.607212314825, 4152.854650087247, 4164.208800327928, 4098.323776576861, 4117.238310912476, 4121.979390103045, 4140.337545992642, 4164.97917510412, 3956.1296514766705, 4035.959640403588, 4059.289624315733, 4169.916601667965, 4173.8330466781445, 3656.177360093984, 3660.1032746976894, 3664.175560498893, 3679.5400574928135, 3688.4467329900463, 5174.2238664200295, 5183.663061900965, 5187.170052791535, 5188.377394712621, 5199.454057324002, 4786.1863483207935, 4792.0, 4796.376471058775, 4798.280257961299, 4800.375951126366, 5507.146392309199, 5637.915431268534, 5641.12562552805, 5644.6330988485615, 5647.661140331593, 4002.3196056670436, 4003.7597744135155, 4004.619561141687, 4005.379166229239, 4006.599340065999, 5860.09168578871, 5945.524358051345, 5950.523958083343, 5951.553633477506, 5952.196453478811, 4108.075682971307, 4113.341865301597, 4116.238495878272, 4121.670266378683, 4121.814518346681, 3785.9519170224185, 3881.592432794516, 4185.958140418617, 4189.224993376174, 4191.958080419156, 4469.307257375112, 4580.862574122782, 4613.19269127908, 4621.6764826462495, 4670.696404733681, 5454.990826697073, 5520.503154716095, 5532.861678458071, 5536.944630553723, 5538.252335934678, 1465.5310300703886, 1479.0238442627815, 1479.4304192885816, 1482.4070371851346, 1482.5700546841294, 999.0459111548454, 1011.1506334678905, 1011.5245834457793, 1019.5513973851481, 1027.3887037212846, 4972.651914366032, 4977.054359671651, 4983.053219888209, 4983.750812459362, 4988.501149884983, 5856.648601083949, 5860.062390017577, 5862.765489380462, 5873.383294754075, 5875.148103524965, 4956.628252881048, 4960.404751429852, 4968.180250258667, 4970.627202959792, 4971.37857767779, 3099.5040793473386, 3133.6709645487354, 3158.9842050790057, 3170.033139892355, 3170.6670799565713, 5600.5799565032785, 5657.2928383952, 5659.773609055592, 5662.2639056922335, 5667.518260947783, 6086.847828804227, 6090.665013424215, 6092.208012958287, 6095.390460953958, 6097.939020609826, 5517.310336207974, 5642.858928526737, 5648.181013752983, 5650.943490565041, 5657.60396772222, 5919.852003699942, 5923.526117910643, 5930.843485520282, 5930.940690593211, 5933.970330148321, 5699.401562835843, 5751.798687045934, 5754.424557544212, 5754.4533269339345, 5759.078547432391, 5637.661740295432, 5639.54883609302, 5644.3508996465935, 5647.3505546861, 5650.830475085754, 3911.882643520699, 3973.463582416337, 4004.899877503086, 4015.2371049500503, 4028.738132021409, 5926.555508336805, 5934.922777028006, 5935.0, 5938.2280303560265, 5940.910886336622, 5674.2623458950075, 5693.686847223443, 5699.572532060195, 5701.686407247641, 5703.030484817508, 5554.02669392413, 5656.943430565641, 5664.320281566238, 5694.601377903507, 5696.344920334214, 5557.5553955682635, 5562.443755624405, 5564.469770813059, 5566.109422492382, 5574.414686457863, 5448.237246785374, 5625.128105143709, 5727.140928860705, 5743.540516758733, 5744.741486633028, 5464.23500709893, 5569.05326094573, 5586.916196257141, 5587.55299576041, 5588.469095435927], "unit": "ms", "name": "prototype.html", "value": 4253.703806793581}, {"lowerIsBetter": false, "replicates": [641.0896526931758, 648.6432462145818, 662.9071929929811, 779.9493032952861, 793.5992323876442, 11099.112071034318, 11318.264312819661, 11329.773404531914, 11342.659720208396, 11359.772804543903, 10713.03582677559, 11954.581589644364, 12060.939695301511, 12061.33662648554, 12126.029917606593, 804.4007214625112, 821.5974172655416, 822.62159406673, 822.983540329193, 823.1274848660439, 806.2501873257868, 814.0313027497289, 816.0126247240846, 816.147126253064, 816.1797393619404, 853.1042405474258, 860.561113831944, 861.4874149880811, 861.6381119929645, 862.017300277684, 851.2721623012297, 851.7189327521934, 853.2960307746104, 853.4751128056263, 854.6453221912899, 631.5105793010408, 632.4023797511354, 632.5919781740797, 633.37612451735, 633.5470138850698, 10267.127294179929, 10415.16678665705, 10456.790864182674, 10460.68617941463, 10483.004114609175, 9475.47884866332, 9919.3056486046, 10059.09468147863, 10129.920342620913, 10261.127804136657, 8788.42875213109, 8861.335399845037, 8908.8663670045, 8970.775730606721, 8993.505357205351, 3171.841407929617, 3215.742740580748, 3219.0986523773145, 3231.8545665445113, 3282.720968717662, 33424.49863252053, 33626.0, 40179.39730904039, 40284.7772178228, 41768.582314176776, 9124.17882390588, 9291.860622090675, 9384.202342800801, 9508.144267016001, 9732.70801875945, 15452.0, 15549.455769048256, 15614.453494127878, 15661.216939152997, 15713.921430392775, 6034.2155519782145, 6162.291336496271, 6204.100405441186, 6252.906206406908, 6277.905831412532, 3528.2590655962535, 3637.781733096023, 3639.8544058237376, 3646.5988741238443, 3651.050726810995, 2673.2782148820097, 2675.304420850554, 2693.7036925938132, 2698.015224443064, 2714.7285271472697, 498.50647858619703, 503.0592791479956, 514.2902794144057, 515.0188890164243, 515.0780103614488, 520.8958208358343, 522.8457605006532, 592.9940700592939, 629.6883042893797, 637.6684124255361, 7176.390006849372, 7582.696692132363, 7711.0, 7988.920110798934, 8137.186281371934, 563.9266895303584, 591.6450129922098, 615.1111643674936, 623.9251289845157, 628.7359309090193, 3414.726821854246, 3449.6032956209856, 3499.2126771476214, 3512.5433693619666, 3683.686886614614, 47663.0, 47890.52109478861, 48105.75947120312, 48230.75884620554, 52628.47371526236, 40413.59586404098, 40710.38934415986, 40717.389239161435, 42573.78713106477, 47128.0, 36053.639463605556, 42527.574724252365, 42614.36078458826, 43408.0, 43629.12741745211, 7891.447598668038, 7993.560354180343, 8213.79465513367, 8216.958915205385, 8396.664133434839, 32291.838540807144, 32433.837830810695, 32469.18827029343, 32976.835115824266, 33172.834135829165, 34502.137446563036, 35025.64974350326, 43753.56246437495, 44656.33015504835, 45021.32468012917, 9634.662786802708, 9919.305648604528, 10200.0, 10314.742131446774, 10690.41202733857, 11551.42242887869, 11692.35692036946, 11729.824052639047, 12077.57728479499, 12310.569130080405, 10468.319559228627, 10702.946485267525, 11065.557377704801, 11114.16643751738, 11275.267107637977, 10456.790864182825, 10954.233203675667, 10991.0, 11009.174311926798, 11492.195546311677, 10724.088452481314, 10734.624288149877, 10767.730806729895, 10944.39805810688, 10987.560497580327, 9275.62897484093, 9456.0, 9590.664326748809, 9747.951260243653, 9753.170980466739, 9312.906870931474, 9854.21166306708, 9863.802723945337, 9876.209903207582, 9881.950590247003], "unit": "ms", "name": "yui.html", "value": 5726.92720984698}], "name": "dromaeo_css", "value": 6382.883763594979}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 110.0, 103.0, 110.0, 109.0, 110.0, 98.0, 108.0, 110.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 107.0}, {"lowerIsBetter": true, "replicates": [151.0, 128.0, 162.0, 168.0, 138.0, 156.0, 153.0, 129.0, 165.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [165.0, 160.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 87.0, 90.0, 72.0, 71.0, 72.0, 98.0, 89.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 135.0, 93.0, 94.0, 94.0, 129.0, 93.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 72.0, 71.0, 70.0, 71.0, 71.0, 83.0, 69.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 83.0, 91.0, 82.0, 85.0, 85.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [120.0, 117.0, 125.0, 122.0, 125.0, 118.0, 129.0, 120.0, 118.0, 135.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 148.0, 155.0, 146.0, 145.0, 145.0, 147.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 67.0, 68.0, 67.0, 66.0, 67.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1514.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.66666666666666], "unit": "score", "name": "Richards", "value": 211.81200000000004}, {"lowerIsBetter": false, "replicates": [185.42555164101614], "unit": "score", "name": "DeltaBlue", "value": 356.5743740000001}, {"lowerIsBetter": false, "replicates": [279.6420581655481], "unit": "score", "name": "Encrypt", "value": 951.8632560000003}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2002.0], "unit": "score", "name": "RayTrace", "value": 369.62487512487513}, {"lowerIsBetter": false, "replicates": [779.423226812159], "unit": "score", "name": "Earley", "value": 855.072029}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [624.0648379052369], "unit": "score", "name": "Splay", "value": 130.58098301698303}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19823.257736516236}]} 09:07:52 INFO - RETURN: dromaeo_css: 6382.88 09:07:52 INFO - RETURN: kraken: 1514.80 09:07:52 INFO - RETURN: v8_7: 19823.26 09:07:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19823.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1514.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6382.88"}}} 09:07:52 INFO - Return code: 0 09:07:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:07:52 ERROR - # TBPL SUCCESS # 09:07:52 INFO - Running post-action listener: _resource_record_post_action 09:07:52 INFO - Running post-run listener: _resource_record_post_run 09:07:53 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509902848; Read time: 8; Write time: 668056 09:07:53 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231440384; Read time: 0; Write time: 450820 09:07:53 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278462464; Read time: 8; Write time: 217236 09:07:53 INFO - Running post-run listener: _upload_blobber_files 09:07:53 INFO - Blob upload gear active. 09:07:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:07:53 INFO - Copying logs to upload dir... 09:07:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.580546 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-02 09:07:54.001046) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 09:07:54.005782) ========= 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=6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010116 build_url: 'https://queue.taskcluster.net/v1/task/VEOTvaeMTK2C5augM281IQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-02 09:07:54.057599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 09:07:54.057958) ========= 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=6d5287d839824eebc594b0c9000001d1-1449074752.554287-227950550 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-02 09:07:54.107984) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 09:07:54.108497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-02 09:07:54.108839) ========= ========= Total master_lag: 0.26 =========