builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1449263236.31 results: success (0) buildid: 20151202073358 builduid: b70adde180df4deb9484abd536016bdc revision: 87204339949047f3c630cb57f37fb6e818d41f5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.309141) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.309638) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.309939) ========= 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=01deea79d00cc2c334834894000001d2-1449263235.113693-890591493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006112 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.333062) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.333413) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.367240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.367616) ========= 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=01deea79d00cc2c334834894000001d2-1449263235.113693-890591493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003173 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.415145) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.415491) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.415883) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.416171) ========= 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=01deea79d00cc2c334834894000001d2-1449263235.113693-890591493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 13:07:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 72.6M=0s 2015-12-04 13:07:16 (72.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.204084 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.634281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.634622) ========= 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=01deea79d00cc2c334834894000001d2-1449263235.113693-890591493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.256064 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.902677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:16.903050) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 87204339949047f3c630cb57f37fb6e818d41f5f --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 87204339949047f3c630cb57f37fb6e818d41f5f --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=01deea79d00cc2c334834894000001d2-1449263235.113693-890591493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 13:07:17,238 truncating revision to first 12 chars 2015-12-04 13:07:17,238 Setting DEBUG logging. 2015-12-04 13:07:17,238 attempt 1/10 2015-12-04 13:07:17,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/872043399490?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 13:07:17,485 unpacking tar archive at: fx-team-872043399490/testing/mozharness/ program finished with exit code 0 elapsedTime=0.517989 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:17.434622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:17.434925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:17.444261) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:17.444601) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 13:07:17.445044) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-04 13:07:17.445362) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=01deea79d00cc2c334834894000001d2-1449263235.113693-890591493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:07:18 INFO - MultiFileLogger online at 20151204 13:07:18 in /builds/slave/test 13:07:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:07:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:07:18 INFO - {'append_to_log': False, 13:07:18 INFO - 'base_work_dir': '/builds/slave/test', 13:07:18 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:07:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:07:18 INFO - 'branch': 'Fx-Team-Non-PGO', 13:07:18 INFO - 'buildbot_json_path': 'buildprops.json', 13:07:18 INFO - 'config_files': ('talos/linux_config.py',), 13:07:18 INFO - 'default_actions': ('clobber', 13:07:18 INFO - 'read-buildbot-config', 13:07:18 INFO - 'download-and-extract', 13:07:18 INFO - 'populate-webroot', 13:07:18 INFO - 'create-virtualenv', 13:07:18 INFO - 'install', 13:07:18 INFO - 'run-tests'), 13:07:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:07:18 INFO - 'download_minidump_stackwalk': True, 13:07:18 INFO - 'download_symbols': 'ondemand', 13:07:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:07:18 INFO - 'tooltool.py': '/tools/tooltool.py', 13:07:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:07:18 INFO - '/tools/misc-python/virtualenv.py')}, 13:07:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:07:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:07:18 INFO - 'installer_path': 'installer.exe', 13:07:18 INFO - 'log_level': 'info', 13:07:18 INFO - 'log_name': 'talos', 13:07:18 INFO - 'log_to_console': True, 13:07:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:07:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:07:18 INFO - 'opt_config_files': (), 13:07:18 INFO - 'pip_index': False, 13:07:18 INFO - 'sps_profile': False, 13:07:18 INFO - 'sps_profile_interval': 0, 13:07:18 INFO - 'suite': 'dromaeojs-e10s', 13:07:18 INFO - 'system_bits': '64', 13:07:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:07:18 INFO - 'title': 'talos-linux64-ix-014', 13:07:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:07:18 INFO - 'use_talos_json': True, 13:07:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:07:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:07:18 INFO - 'work_dir': 'build'} 13:07:18 INFO - ##### 13:07:18 INFO - ##### Running clobber step. 13:07:18 INFO - ##### 13:07:18 INFO - Running pre-action listener: _resource_record_pre_action 13:07:18 INFO - Running main action method: clobber 13:07:18 INFO - rmtree: /builds/slave/test/build 13:07:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:07:19 INFO - Running post-action listener: _resource_record_post_action 13:07:19 INFO - ##### 13:07:19 INFO - ##### Running read-buildbot-config step. 13:07:19 INFO - ##### 13:07:19 INFO - Running pre-action listener: _resource_record_pre_action 13:07:19 INFO - Running main action method: read_buildbot_config 13:07:19 INFO - Using buildbot properties: 13:07:19 INFO - { 13:07:19 INFO - "properties": { 13:07:19 INFO - "buildnumber": 807, 13:07:19 INFO - "product": "firefox", 13:07:19 INFO - "script_repo_revision": "production", 13:07:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:07:19 INFO - "repository": "", 13:07:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:07:19 INFO - "buildid": "20151202073358", 13:07:19 INFO - "slavename": "talos-linux64-ix-014", 13:07:19 INFO - "pgo_build": "False", 13:07:19 INFO - "basedir": "/builds/slave/test", 13:07:19 INFO - "project": "", 13:07:19 INFO - "platform": "ubuntu64_hw", 13:07:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:07:19 INFO - "slavebuilddir": "test", 13:07:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:07:19 INFO - "branch": "fx-team", 13:07:19 INFO - "repo_path": "integration/fx-team", 13:07:19 INFO - "stage_platform": "linux64", 13:07:19 INFO - "builduid": "b70adde180df4deb9484abd536016bdc", 13:07:19 INFO - "revision": "87204339949047f3c630cb57f37fb6e818d41f5f" 13:07:19 INFO - }, 13:07:19 INFO - "sourcestamp": { 13:07:19 INFO - "repository": "", 13:07:19 INFO - "hasPatch": false, 13:07:19 INFO - "project": "", 13:07:19 INFO - "branch": "fx-team-linux64-talos", 13:07:19 INFO - "changes": [ 13:07:19 INFO - { 13:07:19 INFO - "category": null, 13:07:19 INFO - "files": [ 13:07:19 INFO - { 13:07:19 INFO - "url": null, 13:07:19 INFO - "name": "https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 13:07:19 INFO - } 13:07:19 INFO - ], 13:07:19 INFO - "repository": "", 13:07:19 INFO - "rev": "87204339949047f3c630cb57f37fb6e818d41f5f", 13:07:19 INFO - "who": "ttromey@mozilla.com", 13:07:19 INFO - "when": 1449072987, 13:07:19 INFO - "number": 6733342, 13:07:19 INFO - "comments": "Bug 1225192 - remove leading whitespace before prettifying css; r=pbrosset\n", 13:07:19 INFO - "project": "", 13:07:19 INFO - "at": "Wed 02 Dec 2015 08:16:27", 13:07:19 INFO - "branch": "fx-team-linux64-talos", 13:07:19 INFO - "revlink": "", 13:07:19 INFO - "properties": [ 13:07:19 INFO - [ 13:07:19 INFO - "buildid", 13:07:19 INFO - "20151202073358", 13:07:19 INFO - "Change" 13:07:19 INFO - ], 13:07:19 INFO - [ 13:07:19 INFO - "builduid", 13:07:19 INFO - "b70adde180df4deb9484abd536016bdc", 13:07:19 INFO - "Change" 13:07:19 INFO - ], 13:07:19 INFO - [ 13:07:19 INFO - "pgo_build", 13:07:19 INFO - "False", 13:07:19 INFO - "Change" 13:07:19 INFO - ] 13:07:19 INFO - ], 13:07:19 INFO - "revision": "87204339949047f3c630cb57f37fb6e818d41f5f" 13:07:19 INFO - } 13:07:19 INFO - ], 13:07:19 INFO - "revision": "87204339949047f3c630cb57f37fb6e818d41f5f" 13:07:19 INFO - } 13:07:19 INFO - } 13:07:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 13:07:19 INFO - Running post-action listener: _resource_record_post_action 13:07:19 INFO - ##### 13:07:19 INFO - ##### Running download-and-extract step. 13:07:19 INFO - ##### 13:07:19 INFO - Running pre-action listener: _resource_record_pre_action 13:07:19 INFO - Running main action method: download_and_extract 13:07:19 INFO - mkdir: /builds/slave/test/build/tests 13:07:19 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')]} 13:07:19 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:07:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json 13:07:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json 13:07:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:07:19 INFO - Downloaded 1302 bytes. 13:07:19 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:07:19 INFO - Using the following test package requirements: 13:07:19 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:19 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:07:19 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:19 INFO - u'jsshell-linux-x86_64.zip'], 13:07:19 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:07:19 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:19 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:07:19 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:07:19 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:07:19 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 13:07:19 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 13:07:19 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:07:19 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:07:19 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')]} 13:07:19 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:07:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:07:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/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 13:07:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/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 13:07:20 INFO - Downloaded 21774886 bytes. 13:07:20 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 13:07:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:07:20 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 13:07:21 INFO - Return code: 0 13:07:21 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 13:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:21 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/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 13:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/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 13:07:23 INFO - Downloaded 21774886 bytes. 13:07:23 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 13:07:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 13:07:23 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 13:07:25 INFO - Return code: 0 13:07:25 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')]} 13:07:25 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/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 13:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/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 13:07:26 INFO - Downloaded 11132001 bytes. 13:07:26 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 13:07:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 13:07:26 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 13:07:27 INFO - Return code: 0 13:07:27 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')]} 13:07:27 INFO - https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/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 13:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/sVKyaDWXQk2P3TgjcvC9_g/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 13:07:28 INFO - Downloaded 57675849 bytes. 13:07:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:07:28 INFO - mkdir: /builds/slave/test/properties 13:07:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:07:28 INFO - Writing to file /builds/slave/test/properties/build_url 13:07:28 INFO - Contents: 13:07:28 INFO - build_url:https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 13:07:28 INFO - Running post-action listener: _resource_record_post_action 13:07:28 INFO - Running post-action listener: set_extra_try_arguments 13:07:28 INFO - ##### 13:07:28 INFO - ##### Running populate-webroot step. 13:07:28 INFO - ##### 13:07:28 INFO - Running pre-action listener: _resource_record_pre_action 13:07:28 INFO - Running main action method: populate_webroot 13:07:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:07:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:07:28 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 13:07:28 INFO - '../fennec_ids.txt'], 13:07:28 INFO - 'tests': ['tcheck2']}, 13:07:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:07:28 INFO - '--tppagecycles', 13:07:28 INFO - '7'], 13:07:28 INFO - 'tests': ['tsvgm']}}, 13:07:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:07:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:07:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:07:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:07:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:07:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:07:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:28 INFO - 'talos_options': ['--e10s'], 13:07:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:07:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:28 INFO - 'tests': ['damp', 'tps']}, 13:07:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:28 INFO - 'talos_options': ['--e10s'], 13:07:28 INFO - 'tests': ['damp', 'tps']}, 13:07:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:07:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:07:28 INFO - 'other': {'tests': ['a11yr', 13:07:28 INFO - 'ts_paint', 13:07:28 INFO - 'tpaint', 13:07:28 INFO - 'sessionrestore', 13:07:28 INFO - 'sessionrestore_no_auto_restore']}, 13:07:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:07:28 INFO - 'tests': ['a11yr', 13:07:28 INFO - 'ts_paint', 13:07:28 INFO - 'tpaint', 13:07:28 INFO - 'sessionrestore', 13:07:28 INFO - 'sessionrestore_no_auto_restore']}, 13:07:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:07:28 INFO - 'tests': ['a11yr', 13:07:28 INFO - 'ts_paint', 13:07:28 INFO - 'tpaint', 13:07:28 INFO - 'sessionrestore', 13:07:28 INFO - 'sessionrestore_no_auto_restore']}, 13:07:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:07:28 INFO - 'tests': ['a11yr', 13:07:28 INFO - 'ts_paint', 13:07:28 INFO - 'tpaint', 13:07:28 INFO - 'sessionrestore', 13:07:28 INFO - 'sessionrestore_no_auto_restore']}, 13:07:28 INFO - 'other_l64': {'tests': ['a11yr', 13:07:28 INFO - 'ts_paint', 13:07:28 INFO - 'tpaint', 13:07:28 INFO - 'sessionrestore', 13:07:28 INFO - 'sessionrestore_no_auto_restore']}, 13:07:28 INFO - 'other_nol64': {'tests': ['a11yr', 13:07:28 INFO - 'ts_paint', 13:07:28 INFO - 'tpaint', 13:07:28 INFO - 'sessionrestore', 13:07:28 INFO - 'sessionrestore_no_auto_restore']}, 13:07:28 INFO - 'svgr': {'tests': ['tsvgx', 13:07:28 INFO - 'tsvgr_opacity', 13:07:28 INFO - 'tart', 13:07:28 INFO - 'tscrollx', 13:07:28 INFO - 'cart']}, 13:07:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:07:28 INFO - 'tests': ['tsvgx', 13:07:28 INFO - 'tsvgr_opacity', 13:07:28 INFO - 'tart', 13:07:28 INFO - 'tscrollx', 13:07:28 INFO - 'cart']}, 13:07:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:28 INFO - 'tests': ['tp5o']}, 13:07:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:28 INFO - 'talos_options': ['--e10s'], 13:07:28 INFO - 'tests': ['tp5o']}, 13:07:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:28 INFO - 'talos_options': ['--xperf_path', 13:07:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:28 INFO - 'tests': ['tp5n']}, 13:07:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:07:28 INFO - 'talos_options': ['--e10s', 13:07:28 INFO - '--xperf_path', 13:07:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:07:28 INFO - 'tests': ['tp5n']}}, 13:07:28 INFO - 'talos.zip': {'path': '', 13:07:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:07:28 INFO - Running post-action listener: _resource_record_post_action 13:07:28 INFO - ##### 13:07:28 INFO - ##### Running create-virtualenv step. 13:07:28 INFO - ##### 13:07:28 INFO - Running pre-action listener: _resource_record_pre_action 13:07:28 INFO - Running main action method: create_virtualenv 13:07:28 INFO - Creating virtualenv /builds/slave/test/build/venv 13:07:28 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 13:07:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:07:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:07:28 INFO - Using real prefix '/usr' 13:07:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:07:29 INFO - Installing distribute.............................................................................................................................................................................................done. 13:07:31 INFO - Installing pip.................done. 13:07:31 INFO - Return code: 0 13:07:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5911abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, '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': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', '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 13:07:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:07:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:07:31 INFO - Using env: {'DISPLAY': ':0', 13:07:31 INFO - 'HOME': '/home/cltbld', 13:07:31 INFO - 'LANG': 'en_US.UTF-8', 13:07:31 INFO - 'LANGUAGE': 'en_US:en', 13:07:31 INFO - 'LOGNAME': 'cltbld', 13:07:31 INFO - 'MAIL': '/var/mail/cltbld', 13:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:31 INFO - 'MOZ_NO_REMOTE': '1', 13:07:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:31 INFO - 'NO_EM_RESTART': '1', 13:07:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:31 INFO - 'PWD': '/builds/slave/test', 13:07:31 INFO - 'SHELL': '/bin/bash', 13:07:31 INFO - 'SHLVL': '1', 13:07:31 INFO - 'TERM': 'linux', 13:07:31 INFO - 'TMOUT': '86400', 13:07:31 INFO - 'USER': 'cltbld', 13:07:31 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:31 INFO - '_': '/tools/buildbot/bin/python'} 13:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:32 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 13:07:32 INFO - Cleaning up... 13:07:32 INFO - Return code: 0 13:07:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:07:32 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')]} 13:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:32 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')]} 13:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:32 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 0x7fb5911abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, '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': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', '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 13:07:32 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 13:07:32 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 13:07:32 INFO - Using env: {'DISPLAY': ':0', 13:07:32 INFO - 'HOME': '/home/cltbld', 13:07:32 INFO - 'LANG': 'en_US.UTF-8', 13:07:32 INFO - 'LANGUAGE': 'en_US:en', 13:07:32 INFO - 'LOGNAME': 'cltbld', 13:07:32 INFO - 'MAIL': '/var/mail/cltbld', 13:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:32 INFO - 'MOZ_NO_REMOTE': '1', 13:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:32 INFO - 'NO_EM_RESTART': '1', 13:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:32 INFO - 'PWD': '/builds/slave/test', 13:07:32 INFO - 'SHELL': '/bin/bash', 13:07:32 INFO - 'SHLVL': '1', 13:07:32 INFO - 'TERM': 'linux', 13:07:32 INFO - 'TMOUT': '86400', 13:07:32 INFO - 'USER': 'cltbld', 13:07:32 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:32 INFO - '_': '/tools/buildbot/bin/python'} 13:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:32 INFO - Downloading/unpacking psutil>=0.7.1 13:07:32 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 13:07:32 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 13:07:32 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 13:07:32 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 13:07:32 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 13:07:32 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 13:07:34 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:07:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:07:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:34 INFO - Installing collected packages: psutil 13:07:34 INFO - Running setup.py install for psutil 13:07:34 INFO - building 'psutil._psutil_linux' extension 13:07:34 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 13:07:35 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 13:07:36 INFO - building 'psutil._psutil_posix' extension 13:07:36 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 13:07:36 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 13:07:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:07:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:07:36 INFO - Successfully installed psutil 13:07:36 INFO - Cleaning up... 13:07:36 INFO - Return code: 0 13:07:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:36 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 0x7fb5911abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, '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': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', '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 13:07:36 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 13:07:36 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 13:07:36 INFO - Using env: {'DISPLAY': ':0', 13:07:36 INFO - 'HOME': '/home/cltbld', 13:07:36 INFO - 'LANG': 'en_US.UTF-8', 13:07:36 INFO - 'LANGUAGE': 'en_US:en', 13:07:36 INFO - 'LOGNAME': 'cltbld', 13:07:36 INFO - 'MAIL': '/var/mail/cltbld', 13:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:36 INFO - 'MOZ_NO_REMOTE': '1', 13:07:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:36 INFO - 'NO_EM_RESTART': '1', 13:07:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:36 INFO - 'PWD': '/builds/slave/test', 13:07:36 INFO - 'SHELL': '/bin/bash', 13:07:36 INFO - 'SHLVL': '1', 13:07:36 INFO - 'TERM': 'linux', 13:07:36 INFO - 'TMOUT': '86400', 13:07:36 INFO - 'USER': 'cltbld', 13:07:36 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:36 INFO - '_': '/tools/buildbot/bin/python'} 13:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:07:36 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 13:07:36 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 13:07:36 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 13:07:36 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 13:07:36 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 13:07:36 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 13:07:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:07:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:07:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:07:41 INFO - Installing collected packages: mozsystemmonitor 13:07:41 INFO - Running setup.py install for mozsystemmonitor 13:07:41 INFO - Successfully installed mozsystemmonitor 13:07:41 INFO - Cleaning up... 13:07:41 INFO - Return code: 0 13:07:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:41 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 0x7fb5911abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, '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': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', '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 13:07:41 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 13:07:41 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 13:07:41 INFO - Using env: {'DISPLAY': ':0', 13:07:41 INFO - 'HOME': '/home/cltbld', 13:07:41 INFO - 'LANG': 'en_US.UTF-8', 13:07:41 INFO - 'LANGUAGE': 'en_US:en', 13:07:41 INFO - 'LOGNAME': 'cltbld', 13:07:41 INFO - 'MAIL': '/var/mail/cltbld', 13:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:41 INFO - 'MOZ_NO_REMOTE': '1', 13:07:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:41 INFO - 'NO_EM_RESTART': '1', 13:07:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:41 INFO - 'PWD': '/builds/slave/test', 13:07:41 INFO - 'SHELL': '/bin/bash', 13:07:41 INFO - 'SHLVL': '1', 13:07:41 INFO - 'TERM': 'linux', 13:07:41 INFO - 'TMOUT': '86400', 13:07:41 INFO - 'USER': 'cltbld', 13:07:41 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:41 INFO - '_': '/tools/buildbot/bin/python'} 13:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:42 INFO - Downloading/unpacking blobuploader==1.2.4 13:07:42 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 13:07:42 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 13:07:42 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 13:07:42 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 13:07:42 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 13:07:42 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 13:07:43 INFO - Downloading blobuploader-1.2.4.tar.gz 13:07:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:07:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:07:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:07:43 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 13:07:43 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 13:07:43 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 13:07:43 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 13:07:43 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 13:07:43 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 13:07:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:07:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 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 13:07:44 INFO - Downloading docopt-0.6.1.tar.gz 13:07:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:07:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:07:44 INFO - Installing collected packages: blobuploader, requests, docopt 13:07:44 INFO - Running setup.py install for blobuploader 13:07:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:07:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:07:44 INFO - Running setup.py install for requests 13:07:44 INFO - Running setup.py install for docopt 13:07:45 INFO - Successfully installed blobuploader requests docopt 13:07:45 INFO - Cleaning up... 13:07:45 INFO - Return code: 0 13:07:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:45 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 0x7fb5911abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, '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': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', '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 13:07:45 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 13:07:45 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 13:07:45 INFO - Using env: {'DISPLAY': ':0', 13:07:45 INFO - 'HOME': '/home/cltbld', 13:07:45 INFO - 'LANG': 'en_US.UTF-8', 13:07:45 INFO - 'LANGUAGE': 'en_US:en', 13:07:45 INFO - 'LOGNAME': 'cltbld', 13:07:45 INFO - 'MAIL': '/var/mail/cltbld', 13:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:45 INFO - 'MOZ_NO_REMOTE': '1', 13:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:45 INFO - 'NO_EM_RESTART': '1', 13:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:45 INFO - 'PWD': '/builds/slave/test', 13:07:45 INFO - 'SHELL': '/bin/bash', 13:07:45 INFO - 'SHLVL': '1', 13:07:45 INFO - 'TERM': 'linux', 13:07:45 INFO - 'TMOUT': '86400', 13:07:45 INFO - 'USER': 'cltbld', 13:07:45 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:45 INFO - '_': '/tools/buildbot/bin/python'} 13:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:45 INFO - Running setup.py (path:/tmp/pip-jsUZQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:45 INFO - Running setup.py (path:/tmp/pip-M8ch52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:45 INFO - Running setup.py (path:/tmp/pip-Z1PSjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:45 INFO - Running setup.py (path:/tmp/pip-RTPwNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:45 INFO - Running setup.py (path:/tmp/pip-7vopb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:45 INFO - Running setup.py (path:/tmp/pip-zVMp_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:45 INFO - Running setup.py (path:/tmp/pip-XDx0Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:45 INFO - Running setup.py (path:/tmp/pip-nDYY3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:45 INFO - Running setup.py (path:/tmp/pip-87Rikq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:45 INFO - Running setup.py (path:/tmp/pip-PFLkVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:46 INFO - Running setup.py (path:/tmp/pip-XTrU8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:46 INFO - Running setup.py (path:/tmp/pip-7R14gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:46 INFO - Running setup.py (path:/tmp/pip-82IxMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:46 INFO - Running setup.py (path:/tmp/pip-5mIh8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:46 INFO - Running setup.py (path:/tmp/pip-a3DMXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:46 INFO - Running setup.py (path:/tmp/pip-zOncNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:46 INFO - Running setup.py (path:/tmp/pip-nZ3JSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:07:46 INFO - Running setup.py install for manifestparser 13:07:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:07:46 INFO - Running setup.py install for mozcrash 13:07:46 INFO - Running setup.py install for mozdebug 13:07:46 INFO - Running setup.py install for mozdevice 13:07:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:07:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:07:46 INFO - Running setup.py install for mozfile 13:07:47 INFO - Running setup.py install for mozhttpd 13:07:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Running setup.py install for mozinfo 13:07:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Running setup.py install for mozInstall 13:07:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Running setup.py install for mozleak 13:07:47 INFO - Running setup.py install for mozlog 13:07:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Running setup.py install for moznetwork 13:07:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Running setup.py install for mozprocess 13:07:47 INFO - Running setup.py install for mozprofile 13:07:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:07:47 INFO - Running setup.py install for mozrunner 13:07:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:07:48 INFO - Running setup.py install for mozscreenshot 13:07:48 INFO - Running setup.py install for moztest 13:07:48 INFO - Running setup.py install for mozversion 13:07:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:07:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:07:48 INFO - Cleaning up... 13:07:48 INFO - Return code: 0 13:07:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fb5911abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, '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': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', '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 13:07:48 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 13:07:48 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 13:07:48 INFO - Using env: {'DISPLAY': ':0', 13:07:48 INFO - 'HOME': '/home/cltbld', 13:07:48 INFO - 'LANG': 'en_US.UTF-8', 13:07:48 INFO - 'LANGUAGE': 'en_US:en', 13:07:48 INFO - 'LOGNAME': 'cltbld', 13:07:48 INFO - 'MAIL': '/var/mail/cltbld', 13:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:48 INFO - 'MOZ_NO_REMOTE': '1', 13:07:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:48 INFO - 'NO_EM_RESTART': '1', 13:07:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:48 INFO - 'PWD': '/builds/slave/test', 13:07:48 INFO - 'SHELL': '/bin/bash', 13:07:48 INFO - 'SHLVL': '1', 13:07:48 INFO - 'TERM': 'linux', 13:07:48 INFO - 'TMOUT': '86400', 13:07:48 INFO - 'USER': 'cltbld', 13:07:48 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:48 INFO - '_': '/tools/buildbot/bin/python'} 13:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:07:48 INFO - Running setup.py (path:/tmp/pip-k4cz3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:07:48 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)) 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:07:48 INFO - Running setup.py (path:/tmp/pip-fsd2df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:07:48 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)) 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:07:48 INFO - Running setup.py (path:/tmp/pip-tM8cuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:07:48 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)) 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:07:48 INFO - Running setup.py (path:/tmp/pip-TNFLaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:07:48 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)) 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:07:48 INFO - Running setup.py (path:/tmp/pip-e3hb8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:07:48 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)) 13:07:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:07:48 INFO - Running setup.py (path:/tmp/pip-L7N9SK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:07:49 INFO - Running setup.py (path:/tmp/pip-kBkoVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:07:49 INFO - Running setup.py (path:/tmp/pip-Jtt1o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:07:49 INFO - Running setup.py (path:/tmp/pip-zngXHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:07:49 INFO - Running setup.py (path:/tmp/pip-Xdjiel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:07:49 INFO - Running setup.py (path:/tmp/pip-ZbzYXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:07:49 INFO - Running setup.py (path:/tmp/pip-jz3s6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:07:49 INFO - Running setup.py (path:/tmp/pip-GRpiTi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:07:49 INFO - Running setup.py (path:/tmp/pip-OEDkSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:49 INFO - Running setup.py (path:/tmp/pip-bN3z35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:07:49 INFO - Running setup.py (path:/tmp/pip-QxePzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:07:49 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)) 13:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:07:49 INFO - Running setup.py (path:/tmp/pip-qc7c9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:07:49 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)) 13:07:49 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)) 13:07:49 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)) 13:07:49 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)) 13:07:49 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)) 13:07:49 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)) 13:07:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:07:49 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 13:07:49 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 13:07:49 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 13:07:49 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 13:07:49 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 13:07:49 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 13:07:51 INFO - Downloading blessings-1.5.1.tar.gz 13:07:51 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 13:07:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:07:51 INFO - Installing collected packages: blessings 13:07:51 INFO - Running setup.py install for blessings 13:07:51 INFO - Successfully installed blessings 13:07:51 INFO - Cleaning up... 13:07:51 INFO - Return code: 0 13:07:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:07:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:51 INFO - Reading from file tmpfile_stdout 13:07:51 INFO - Current package versions: 13:07:51 INFO - argparse == 1.2.1 13:07:51 INFO - blessings == 1.5.1 13:07:51 INFO - blobuploader == 1.2.4 13:07:51 INFO - docopt == 0.6.1 13:07:51 INFO - manifestparser == 1.1 13:07:51 INFO - mozInstall == 1.12 13:07:51 INFO - mozcrash == 0.16 13:07:51 INFO - mozdebug == 0.1 13:07:51 INFO - mozdevice == 0.47 13:07:51 INFO - mozfile == 1.2 13:07:51 INFO - mozhttpd == 0.7 13:07:51 INFO - mozinfo == 0.9 13:07:51 INFO - mozleak == 0.1 13:07:51 INFO - mozlog == 3.1 13:07:51 INFO - moznetwork == 0.27 13:07:51 INFO - mozprocess == 0.22 13:07:51 INFO - mozprofile == 0.27 13:07:51 INFO - mozrunner == 6.11 13:07:51 INFO - mozscreenshot == 0.1 13:07:51 INFO - mozsystemmonitor == 0.0 13:07:51 INFO - moztest == 0.7 13:07:51 INFO - mozversion == 1.4 13:07:51 INFO - psutil == 3.1.1 13:07:51 INFO - requests == 1.2.3 13:07:51 INFO - wsgiref == 0.1.2 13:07:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:07:51 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')]} 13:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:51 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')]} 13:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:51 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 0x7fb5911abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, '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': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', '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 13:07:51 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 13:07:51 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 13:07:51 INFO - Using env: {'DISPLAY': ':0', 13:07:51 INFO - 'HOME': '/home/cltbld', 13:07:51 INFO - 'LANG': 'en_US.UTF-8', 13:07:51 INFO - 'LANGUAGE': 'en_US:en', 13:07:51 INFO - 'LOGNAME': 'cltbld', 13:07:51 INFO - 'MAIL': '/var/mail/cltbld', 13:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:51 INFO - 'MOZ_NO_REMOTE': '1', 13:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:51 INFO - 'NO_EM_RESTART': '1', 13:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:51 INFO - 'PWD': '/builds/slave/test', 13:07:51 INFO - 'SHELL': '/bin/bash', 13:07:51 INFO - 'SHLVL': '1', 13:07:51 INFO - 'TERM': 'linux', 13:07:51 INFO - 'TMOUT': '86400', 13:07:51 INFO - 'USER': 'cltbld', 13:07:51 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:51 INFO - '_': '/tools/buildbot/bin/python'} 13:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 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)) 13:07:52 INFO - Cleaning up... 13:07:52 INFO - Return code: 0 13:07:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5911abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, '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': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', '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 13:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:07:52 INFO - Using env: {'DISPLAY': ':0', 13:07:52 INFO - 'HOME': '/home/cltbld', 13:07:52 INFO - 'LANG': 'en_US.UTF-8', 13:07:52 INFO - 'LANGUAGE': 'en_US:en', 13:07:52 INFO - 'LOGNAME': 'cltbld', 13:07:52 INFO - 'MAIL': '/var/mail/cltbld', 13:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:52 INFO - 'MOZ_NO_REMOTE': '1', 13:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:52 INFO - 'NO_EM_RESTART': '1', 13:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:52 INFO - 'PWD': '/builds/slave/test', 13:07:52 INFO - 'SHELL': '/bin/bash', 13:07:52 INFO - 'SHLVL': '1', 13:07:52 INFO - 'TERM': 'linux', 13:07:52 INFO - 'TMOUT': '86400', 13:07:52 INFO - 'USER': 'cltbld', 13:07:52 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:52 INFO - '_': '/tools/buildbot/bin/python'} 13:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:52 INFO - Downloading/unpacking jsonschema 13:07:52 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 13:07:52 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 13:07:52 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 13:07:52 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 13:07:52 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 13:07:52 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 13:07:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:07:54 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 13:07:54 INFO - Downloading/unpacking functools32 (from jsonschema) 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:54 INFO - Downloading functools32-3.2.3-2.tar.gz 13:07:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:07:54 INFO - warning: no files found matching '*.txt' 13:07:54 INFO - no previously-included directories found matching 'build' 13:07:54 INFO - no previously-included directories found matching 'dist' 13:07:54 INFO - no previously-included directories found matching '.git*' 13:07:54 INFO - Installing collected packages: jsonschema, functools32 13:07:54 INFO - Running setup.py install for functools32 13:07:54 INFO - warning: no files found matching '*.txt' 13:07:54 INFO - no previously-included directories found matching 'build' 13:07:54 INFO - no previously-included directories found matching 'dist' 13:07:54 INFO - no previously-included directories found matching '.git*' 13:07:54 INFO - Successfully installed jsonschema functools32 13:07:54 INFO - Cleaning up... 13:07:54 INFO - Return code: 0 13:07:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:07: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')]} 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07: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')]} 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:07:54 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 0x7fb5911abf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11de8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12ac240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, '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': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', '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 13:07:54 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 13:07:54 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 13:07:54 INFO - Using env: {'DISPLAY': ':0', 13:07:54 INFO - 'HOME': '/home/cltbld', 13:07:54 INFO - 'LANG': 'en_US.UTF-8', 13:07:54 INFO - 'LANGUAGE': 'en_US:en', 13:07:54 INFO - 'LOGNAME': 'cltbld', 13:07:54 INFO - 'MAIL': '/var/mail/cltbld', 13:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:07:54 INFO - 'MOZ_NO_REMOTE': '1', 13:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:07:54 INFO - 'NO_EM_RESTART': '1', 13:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:07:54 INFO - 'PWD': '/builds/slave/test', 13:07:54 INFO - 'SHELL': '/bin/bash', 13:07:54 INFO - 'SHLVL': '1', 13:07:54 INFO - 'TERM': 'linux', 13:07:54 INFO - 'TMOUT': '86400', 13:07:54 INFO - 'USER': 'cltbld', 13:07:54 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:07:54 INFO - '_': '/tools/buildbot/bin/python'} 13:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:07:54 INFO - Downloading/unpacking flake8 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:07:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:07:56 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 13:07:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:07:56 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 13:07:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:56 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 13:07:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:07:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:07:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:07:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:07:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:07:57 INFO - no previously-included directories found matching 'docs/_build' 13:07:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:07:57 INFO - Running setup.py install for pep8 13:07:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:07:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:07:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:07:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:07:57 INFO - no previously-included directories found matching 'docs/_build' 13:07:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:07:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:07:57 INFO - Cleaning up... 13:07:57 INFO - Return code: 0 13:07:57 INFO - Running post-action listener: _resource_record_post_action 13:07:57 INFO - Running post-action listener: _start_resource_monitoring 13:07:57 INFO - Starting resource monitoring. 13:07:57 INFO - ##### 13:07:57 INFO - ##### Running install step. 13:07:57 INFO - ##### 13:07:57 INFO - Running pre-action listener: _resource_record_pre_action 13:07:57 INFO - Running main action method: install 13:07:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:07:57 INFO - Reading from file tmpfile_stdout 13:07:57 INFO - Detecting whether we're running mozinstall >=1.0... 13:07:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:07:57 INFO - Reading from file tmpfile_stdout 13:07:57 INFO - Output received: 13:07:57 INFO - Usage: mozinstall [options] installer 13:07:57 INFO - Options: 13:07:57 INFO - -h, --help show this help message and exit 13:07:57 INFO - -d DEST, --destination=DEST 13:07:57 INFO - Directory to install application into. [default: 13:07:57 INFO - "/builds/slave/test"] 13:07:57 INFO - --app=APP Application being installed. [default: firefox] 13:07:57 INFO - mkdir: /builds/slave/test/build/application 13:07:57 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'] 13:07:57 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 13:08:12 INFO - Reading from file tmpfile_stdout 13:08:12 INFO - Output received: 13:08:12 INFO - /builds/slave/test/build/application/firefox/firefox 13:08:12 INFO - Running post-action listener: _resource_record_post_action 13:08:12 INFO - ##### 13:08:12 INFO - ##### Running run-tests step. 13:08:12 INFO - ##### 13:08:12 INFO - Running pre-action listener: _resource_record_pre_action 13:08:12 INFO - Running main action method: run_tests 13:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:08:12 INFO - Python 2.7.3 13:08:12 INFO - Return code: 0 13:08:12 INFO - grabbing minidump binary from tooltool 13:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:08:12 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 0x133b0b0>, '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 0x133bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:08:12 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 13:08:12 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 13:08:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:08:12 INFO - Return code: 0 13:08:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:08:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:08:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:08:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:08:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:08:13 INFO - Return code: 0 13:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] in /builds/slave/test/build 13:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost 13:08:13 INFO - Using env: {'DISPLAY': ':0', 13:08:13 INFO - 'HOME': '/home/cltbld', 13:08:13 INFO - 'LANG': 'en_US.UTF-8', 13:08:13 INFO - 'LANGUAGE': 'en_US:en', 13:08:13 INFO - 'LOGNAME': 'cltbld', 13:08:13 INFO - 'MAIL': '/var/mail/cltbld', 13:08:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:08:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:08:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:13 INFO - 'MOZ_NO_REMOTE': '1', 13:08:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:08:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:13 INFO - 'NO_EM_RESTART': '1', 13:08:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:13 INFO - 'PWD': '/builds/slave/test', 13:08:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:08:13 INFO - 'SHELL': '/bin/bash', 13:08:13 INFO - 'SHLVL': '1', 13:08:13 INFO - 'TERM': 'linux', 13:08:13 INFO - 'TMOUT': '86400', 13:08:13 INFO - 'USER': 'cltbld', 13:08:13 INFO - 'XDG_SESSION_COOKIE': '01deea79d00cc2c334834894000001d2-1449263235.113693-890591493', 13:08:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:13 INFO - '_': '/tools/buildbot/bin/python'} 13:08:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost'] with output_timeout 3600 13:08:13 INFO - mozversion INFO | application_buildid: 20151202073358 13:08:13 INFO - mozversion INFO | application_changeset: 87204339949047f3c630cb57f37fb6e818d41f5f 13:08:13 INFO - mozversion INFO | application_display_name: Nightly 13:08:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:08:13 INFO - mozversion INFO | application_name: Firefox 13:08:13 INFO - mozversion INFO | application_remotingname: firefox 13:08:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 13:08:13 INFO - mozversion INFO | application_vendor: Mozilla 13:08:13 INFO - mozversion INFO | application_version: 45.0a1 13:08:13 INFO - mozversion INFO | platform_buildid: 20151202073358 13:08:13 INFO - mozversion INFO | platform_changeset: 87204339949047f3c630cb57f37fb6e818d41f5f 13:08:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 13:08:13 INFO - mozversion INFO | platform_version: 45.0a1 13:08:13 INFO - 2015-12-04 13:08:13,517 DEBUG : using testdate: 1449263293 13:08:13 INFO - 2015-12-04 13:08:13,518 DEBUG : actual date: 1449263293 13:08:13 INFO - 2015-12-04 13:08:13,526 INFO : starting webserver on 'localhost:40702' 13:08:13 INFO - 2015-12-04 13:08:13,527 INFO : Starting test suite talos-linux64-ix-014.e 13:08:13 INFO - 2015-12-04 13:08:13,527 INFO : Starting test dromaeo_css 13:08:13 INFO - 2015-12-04 13:08:13,527 DEBUG : operating with platform_type : linux_ 13:08:13 INFO - 2015-12-04 13:08:13,527 INFO : Initialising browser for dromaeo_css test... 13:08:13 INFO - 2015-12-04 13:08:13,551 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiNSJay/profile http://localhost:40702/getInfo.html 13:08:19 INFO - 2015-12-04 13:08:19,943 DEBUG : BROWSER_OUTPUT: console.error: 13:08:19 INFO - 2015-12-04 13:08:19,943 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:08:19 INFO - 2015-12-04 13:08:19,943 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:08:21 INFO - 2015-12-04 13:08:21,189 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:08:21 INFO - 2015-12-04 13:08:21,189 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:08:21 INFO - 2015-12-04 13:08:21,189 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:08:21 INFO - 2015-12-04 13:08:21,189 DEBUG : BROWSER_OUTPUT: __metrics 13:08:21 INFO - 2015-12-04 13:08:21,331 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] 13:08:22 INFO - 2015-12-04 13:08:22,257 INFO : Browser initialized. 13:08:22 INFO - 2015-12-04 13:08:22,258 INFO : Running cycle 1/1 for dromaeo_css test... 13:08:22 INFO - 2015-12-04 13:08:22,258 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiNSJay/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:08:23 INFO - 2015-12-04 13:08:23,857 DEBUG : BROWSER_OUTPUT: console.error: 13:08:23 INFO - 2015-12-04 13:08:23,857 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:08:23 INFO - 2015-12-04 13:08:23,857 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:08:34 INFO - 2015-12-04 13:08:34,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 144207872 13:08:34 INFO - 2015-12-04 13:08:34,219 DEBUG : BROWSER_OUTPUT: 13:09:23 INFO - 2015-12-04 13:09:23,863 DEBUG : BROWSER_OUTPUT: 1449263363862 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] 13:11:35 INFO - 2015-12-04 13:11:35,914 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40702/tests/dromaeo/cssquery-ext.html) 13:11:36 INFO - 2015-12-04 13:11:36,918 DEBUG : BROWSER_OUTPUT: RSS: Main: 147820544 13:11:36 INFO - 2015-12-04 13:11:36,918 DEBUG : BROWSER_OUTPUT: 13:14:39 INFO - 2015-12-04 13:14:39,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/dromaeo/cssquery-ext.html (next: http://localhost:40702/tests/dromaeo/cssquery-jquery.html) 13:14:39 INFO - 2015-12-04 13:14:39,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 144949248 13:14:39 INFO - 2015-12-04 13:14:39,645 DEBUG : BROWSER_OUTPUT: 13:17:41 INFO - 2015-12-04 13:17:41,435 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40702/tests/dromaeo/cssquery-mootools.html) 13:17:42 INFO - 2015-12-04 13:17:42,036 DEBUG : BROWSER_OUTPUT: RSS: Main: 146915328 13:17:42 INFO - 2015-12-04 13:17:42,036 DEBUG : BROWSER_OUTPUT: 13:20:43 INFO - 2015-12-04 13:20:43,802 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40702/tests/dromaeo/cssquery-prototype.html) 13:20:44 INFO - 2015-12-04 13:20:44,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 144146432 13:20:44 INFO - 2015-12-04 13:20:44,404 DEBUG : BROWSER_OUTPUT: 13:23:47 INFO - 2015-12-04 13:23:47,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40702/tests/dromaeo/cssquery-yui.html) 13:23:47 INFO - 2015-12-04 13:23:47,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 143241216 13:23:47 INFO - 2015-12-04 13:23:47,721 DEBUG : BROWSER_OUTPUT: 13:26:49 INFO - 2015-12-04 13:26:49,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/dromaeo/cssquery-yui.html (next: http://localhost:40702/tests/dromaeo/cssquery-dojo.html) 13:26:50 INFO - 2015-12-04 13:26:50,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 147132416 13:26:50 INFO - 2015-12-04 13:26:50,235 DEBUG : BROWSER_OUTPUT: 13:26:50 INFO - 2015-12-04 13:26:50,235 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:26:50 INFO - 2015-12-04 13:26:50,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:26:50 INFO - 2015-12-04 13:26:50,235 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:26:50 INFO - 2015-12-04 13:26:50,235 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:26:50 INFO - 2015-12-04 13:26:50,239 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2655.4821809747095;2699.5545734953735;2716.782657387409;2721.034032918315;2735.9589606155905;4664.323673067403;4738.123447162273;4755.667103302771;4788;4829.396325459317;4645.930311045328;4727.290906364047;4756.429228492577;4773.403324584427;4777.378940737708;4360.738355698668;4395.912081758363;4419.248727716296;4431.64546836254;4437;4365.847195348163;4401.339799030139;4406.5593440656;4407.537208593099;4419.447569053868;4199.370094485821;4224.345226489899;4346.978265108686;4359.607635312837;4415.183191109639;4391.077873646506;4399.934000989988;4407.206702793496;4417.249067658506;4442.400275962736;4142.689298302609;4381.802818873159;4387;4396.824127034914;4435.667324950609;4538.818447262105;4574.130915126116;4680.040591678731;4706.176419126639;4709.599684026862;5049.242613607951;5081.415637201732;5127.6154288428515;5127.8205262816;5144.871378215575;4950.925736113961;5087.974560127176;5139.8458046258675;5166.974165129188;5198;4582.175208462475;4689.695169813951;4713.905721885543;4722.6221902247735;4750.857474275777;5224.92162617561;5254.632175747737;5258.789648414021;5270.235815806686;5310;4789.449213340441;4880.731559764247;5054.671446355975;5055.064813009605;5058.620603454756;5006.524380183877;5069.518395752398;5075.3402057732255;5082.847514574569;5143.12566863634;4950.36637909489;4998.500149985045;5001.424836143818;5010.198368261061;5016.1221786188;4829.420469543677;4881.658283920163;4948.617780984818;4949.950500494949;4972.154733695281;4211.873643790691;4225.323948168279;4239.97880010598;4247.660187185018;4257.063446041866;3693.224422871227;3701.9629803702155;3716.2939041582013;3752.3620984432714;3753.774773513598;4242.109157076987;4354.020345422318;4361.847335343247;4406.1187762447635;4463.843765468193;5123.769430375642;5125.077486052472;5132.050570644443;5145.408278047998;5171.198464238049;4419.9779001105435;4422.115576884636;4423.358613001097;4428.557144285545;4453.755043472575;4290.399344091829;4379.321205213197;4404.339349097597;4458.286674132188;4501.0547784964865;4782.497837726988;4816.8795780105775;4850.563449289581;4852.708837469763;4874.756262186947;4843.782029808596;4988.152014157675;5055.494450555062;5061.215511595708;5129.358830146231;4738.549837765407;4745.9050818984115;4822.758862056813;4828.251620998751;4864.464908859952;4978.626603004862;5005.549500544968;5036.093503169464;5063.87340316495;5079.390473143247;4904.509549045067;5044.47033061538;5096.133657278346;5108.131617625087;5141.614378921521;4866;4938.407391113089;4942.827001054946;4947.604191664586;4985.675931064469;4913.754312284443;4936.925946110883;4939.209726443752;4954.752262386794;4989.525995030466;4629.4676112247525;4672.696274742131;4740.6681532292405;4832.95167048325;4892.608591312757;5005.649604527648;5045.949540504548;5051.4695956924;5060.2156665716875;5060.746962651926;4898.804047838189;4925.950740492693;4928.890999525078;4943.332650092191;4961.875953101201 13:26:50 INFO - 2015-12-04 13:26:50,240 DEBUG : BROWSER_OUTPUT: |1;ext.html;532.0831775432137;568.1449418624969;579.333766168906;591.1074277840461;598.6049207523034;33648.32703345932;34111.488327675106;34164.487532686966;34191;34361.48457773135;39647;40315.59684403155;40472.190556188856;40656.39015414771;40753.59246407535;7954.801129971754;8176.550289734062;8177.5911204439835;8184.304334131606;8187.38594605404;7937.642806073741;8023.518588884656;8037.718679846206;8043.638036288381;8049.315808156313;7946.16565260648;7996.520208787462;8013.198680131969;8032.3574114071025;8045.879311810328;8026.357891368706;8055.718049868285;8090.757277281691;8097.635606397726;8112.918870811275;7918.485298455639;7965.163657815904;8020.639071241808;8029.277365037175;8040.919590804076;37013;37464;37552;37614;37645.43531847024;2872.971270287291;2902.324841713972;2950.0707277207825;3088.243380371801;3321.501774733785;27470.862645686644;28288.858555707295;28352.432951341063;28428.28929276764;28566.428671426456;3199.9200019999453;3234.67653234677;3270.73834093272;3272.312814308998;3300.1914530939835;209722;210662;210813;211263.94368028216;212244;54028.45971540313;54408.45591544034;54439.72780136074;54476;54514;49234;50031.24953125706;57914;59497.405025949185;59781.70109149513;12833.230006199658;12861.678458038437;12868.22790632565;12878.162919410208;12973.286469244282;10272.948635256776;10557.736056598493;10593.788124237471;10595.735106622396;10648.148148148284;19052.952087635313;19470.0311687796;19678.212871485266;19700;19786.90106549458;7478.663460144307;7694.192109828499;7819.765407037798;7836.294733474015;7853.018372703412;832.9791755206169;900.4642237868458;912.224609082288;922.5156792683895;929.8047410043831;25940;26232.73767262303;26302.736972630413;26412.603810942852;26443.297938288655;937.6952490440498;971.1842052675786;977.1791694976254;1054.8048611006989;1138.123644793521;13711.314434278445;13823;13906.374213160432;13950.162990220619;14006.929965350108;271256;273041;273062;273956;274744;44302;44379.778101109936;44569.77715111404;44995.77502112468;45026.099478010256;1205.445495072259;1213.5449206547544;1214.241099312947;1239.2254840724547;1246.4141853328922;24753;25767.871160644827;25860.612090819028;26304.34239144037;26490.337741555843;40358.1928361437;40816.97957551085;40856.182876341714;40859.79570102131;40900;244608;245650;246218;247670;248136;25642.48715025652;26553.60169597419;28611.71388286174;29859.70140298569;30854;34498;34947.825260873535;34967.475487868214;35063.29873402569;37829.81085094557;29919.700802992564;30158.396832062797;30220.395592088476;30295;30510.542341864446;32387.51418728674;32397;32429.51355729713;33018.834905825315;33491.33017339591;32426.83786581052;32909.50635740418;32911.506327404626;33078.834605826814;33922;26233.868830656487;27336;28106.156815295573;28118;28440;22994.250441795324;23513.88243058774;23797.167099151447;23863.880680596485;24044.51910961806 13:26:50 INFO - 2015-12-04 13:26:50,243 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.664009350556;332.78036495912704;334.7723547987369;335.85726066421773;337.54937158892875;15030.323635436403;15561.766573501407;15882.364705411785;16098.7585186222;16725.330986760517;9431.858522122157;9486.81026379472;9527.094925982037;9670.323077384568;9865.802683946316;4407.162639098577;4522.6155776759015;4548.681592288541;4560.8859778505475;4570.154521413532;4485.932711009337;4855.781489832966;5037.11850426174;5037.924431133536;5044.82343117991;3366.276250606119;3447.2933048725076;5007.84976450707;5027.648064635477;5117.667351622151;5169.276301317818;5203.063448579254;5212.50481204285;5227.660202086871;5258.947410525903;4842.201036828919;4854.320395144682;4874.561289483963;5055.064813009605;5065.442801291855;11021.118310535217;11024.118070554417;11202.327860328407;11412.828807567894;19435.514112147168;1852.9166187521594;1892.5552495163627;1920.6062757134894;1942.9417117486498;1989.5523507210762;8903;10236.48817559119;12427.813582796265;12778.10553261272;13002.804957925639;1735.3926125855849;1740.5474576610172;1770.6547223291464;1806.2504060814747;1826.3333883132561;55797.44202557963;56249.15626265609;56775.432245677424;56938.430615693724;57277.427225727624;9493.857592135986;9691.07934746198;9769.16962058233;9834;9916.355436896578;11628.592999244986;11646.76706465866;11690;11728.589499367481;11750;6792.42264407521;6905.827354316082;6969.721211151598;7071.92928070723;7131;6396.680165991682;6437.581557198767;6477.4170324671;6484.805455836333;6516;3925.391564307537;3978.4827972363987;4186.958130418657;4203.327467605169;4227.217964676544;1667.84989350959;1673.4644913627521;1690.3407671008317;1726.0765490462793;1743.4595275464646;363.1502284653923;370.66640023978636;372.8471326756071;890.5547226386807;903.3676426501476;9524.285678574135;9635.518224088768;9686.128248457673;9787.070228328297;9840.803183936281;376.8002958432035;382.52757844062563;382.8162482008651;384.53279265692316;395.1326837591459;3867.971900029362;5264.6838290427395;5316.043112239757;5363.597730170253;5391.676499410048;493783;495381;497579;506818;507515;70468.64765676242;71306.57386852338;72501.63749181326;74470.62764686142;76798.6160069196;1031.8400647899587;1062.516554967488;1062.7608788022633;1063.3460421840666;1073.6564299424265;14810.25948702539;14855.108693478425;14949.476768313058;14967.550973470814;15230.010049346756;32478.83760581182;33203.667963320055;33320.33359332848;34166.316673666886;34592;42727.57272427236;43439.78280108579;44883.326750098124;45024.54975450203;45268.77365613151;8005.75982720496;8330.166983301622;8341.916580834357;8387.95806020966;8475.74572762818;15766;15906.68186636284;16008;16177.59556011109;17035.659286814443;13926.094803837717;14034.929825350808;14134.15195088298;14405.92797036008;14411.711765764836;12262.570810021607;13378;13742.312884355542;13969.371378287799;14392.42430302818;14464.783028254795;14600.561983140522;14721.33753981052;14777.926110369379;14935.17856517902;8375.41372103947;8394.832103358021;8407.327413806759;8432.53621050848;8440.957795210985;10925.672229833117;14119.058329584563;14135.293235338399;14155.64610884736;14221.928890355483 13:26:50 INFO - 2015-12-04 13:26:50,245 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1447.2691290898094;1634.664893696792;1679.1855949864314;1702.344597330028;1706.1042952449961;6333.5883167594075;6435.742570297194;6907.343802338783;7268.600226987513;7324.08448943882;6947.201071876736;7177.35403813658;7234.819129521765;7246.7825965221;7290.979262903198;2084.3225951565764;2090.3833369156137;2127.7233959585233;2128.9148434062695;2129.637961546533;2080.9687854682193;2092.5187206942414;2095.1200495791804;2115.947101322464;2126.479012641905;2061.556765295461;2073.3365323096614;2087.290321290761;2090.508730448351;2091.989540052298;2065.5662310914727;2085.9374218773387;2088.3421722157473;2088.937331880046;2091.4144039668995;2056.085042156241;2086.95826083479;2088.6136064828056;2093.7801530839197;2099.580083983194;7051.400630946376;7147.606881621508;7162.820929476805;7163.3552980232025;7176.210616832144;4070.959290407088;4117.300058989979;4147.6267135957605;4160.521540022875;4169.478815148106;2319.176692274252;2380.1074597026113;2686.435848471823;2699.3656490724666;2700.1089640418613;836.3225787112458;873.8995015573227;893.4326702543931;904.068809126594;911.7447114807865;9468.005859384803;9554.713358599252;9579.042095790364;9586.90413095867;9598.66404675833;3840.9231815363537;3931.488906442144;3932.2135572885536;3952.26883026641;3965.603439656069;8383.329333653415;8395.95802020986;8405.201505856934;8419.873701894476;8422;4225.936610950838;4247.97876010618;4250.4899412070135;4260;4266.274733295285;3803.676687481595;3840.731148819612;3868.419737039467;3869.903252418712;3871.3999330103316;3335.7998520088872;3384.4077286474767;3392.2367467319655;3426.8971930842113;3436.7937923724658;1089.629525961161;1105.1545567640762;1106.607154460155;1110.4947249001684;1120.557379834977;1122.9831552526718;1184.7571247894161;1197.7424853656332;1200.8138738495547;1224.240970598217;6825.1127353443735;6840.281770414134;6932.272111428329;6938.965305173442;6939.583624982517;400.87572852415263;408.85281298732434;412.7894773665452;413.5988091551251;415.00399042298125;5320.733963301896;5344.545713614386;5360.946390536123;5423.864403389947;5424.972875135599;7580.204078571671;7778.338841198448;8412.8317433651;8560.315174786003;8569.442986205877;8338.332933365316;8342.249197572248;8378.790530236793;8389.832203355898;8457.112003239694;6531.477481801445;6545.378189071936;6558.737650493927;6682.164729408824;6791.898121528181;6380.680965951591;6411.935880641134;6421.903671444838;6429.871402571829;6437.0666253392055;7417.294022374992;7420.295071968154;7582.696692132474;7631.809204769926;7638.274363935418;7717.884231736416;7813.843723125619;7911.683532658629;7928.682852685828;7995.320397766255;6318.905216421849;6336.936630633634;6352.396522330371;6368.331325210971;6431.871362572816;6650.866982660416;6691;6726.529142960141;6741.325867413219;6752.898706519504;6363.96818015907;6401;6449.193850768654;6510.153680021567;6548.377904099103;6425.389587989133;6434.935650643621;6473.093766872736;6495.1556297681;6512.381323774234;6553.836154096186;6616.933830661632;6619.702113404812;6624.90062649051;6641.867162656817;5936.436038576328;6037.728302226323;6050.45545900871;6062.545309101747;6078.027515597483;6021.2473440819895;6046.09308603713;6115.877682446415;6120.663363515049;6157.53818463626 13:26:50 INFO - 2015-12-04 13:26:50,248 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.37490457491555;302.2986670923457;306.8818504875623;309.6098915366637;310.5062949909643;5441.401445840955;5469.124940009599;5548.223248745169;5575.804846830361;5638.238837756901;5369.328833895763;5542.612017158801;5551.944480555193;5555.583331250152;5579.7489112989915;4272.594103560157;4280;4284.550122237167;4293.549177336382;4294.570542945712;4287.056847493562;4293.785310734466;4299.269124248885;4303.462067241595;4304.784760761965;4057.2088442753675;4203.894902627429;4262.573742625744;4265.53079161292;4268.253055715253;4193.1404062167185;4194.496660400741;4194.643455306303;4197.454330936989;4219.156168766243;3663.7984910829896;3671.9816400917825;3673.6326367363317;3676.8345424455697;3681.8159092045557;5230.686158830483;5235.476452354772;5236.764345604457;5267.3679158500845;5291.788328466857;4789.449213340476;4790.065937142259;4825.686330388514;4834.468208497063;4843.07981483517;5633.267675202238;5839.532837373;5840.941590584082;5845.327787304472;5857.648541087548;3972.880813575597;3973.304671682444;3974.1455587048636;3978.3435733104;3980.4029395590605;6097.603655762361;6127.172831667713;6145.078238264251;6155.58421563043;6171.413715697002;3923.372260438316;4104.835806567764;4116.238495878212;4121.876343709693;4130.380442933524;4064.8577299794365;4078.938815917764;4080.81636326366;4098.4467096941535;4104;4706.247000479907;4711.222648263067;4714.528547145258;4730.101280756645;4734.07685501324;5734.627249228787;5805.88388232233;5809;5809.2738407699035;5809.854753631109;1435.7415665180367;1438.8057612222217;1460.8466111058399;1469.7868809022846;1475.859793319633;962.6486332488591;986.1814693804125;987.3039507147444;1002.1682003936716;1002.5087707023506;5000.349954505891;5001.174806157016;5004.924926126111;5044.243363495431;5059.418166910778;5988.970055149784;5998.25021872266;6003.519718422515;6011.3086994995265;6017.187679663277;5023.472535383805;5045.2432135180015;5049.899002019939;5060.1903695408555;5068.41713202979;3198.3123628420003;3237.2877966847254;3269.3134441767497;3271.5910511186103;3308.106811160973;5776.797812076557;5790.594658373958;5826.650400975955;5830.504407125357;5831.941680583224;6273.18448601688;6312.179416675803;6322.051692246107;6331.810045698637;6344.49244060474;5670.347909990239;5697.800576979868;5767.394423585547;5786.566007549451;5824.650520968671;6106.9083963739695;6108.35862234459;6118.418750218722;6126.20359353299;6148.354422785722;5975.940240597713;5990.251218597676;5990.371011043778;5996.760129594767;5997.760089596542;5811.418858114154;5816.127580862904;5824.883502330014;5825.242718446575;5826.41735826414;3978.741381810173;4052;4092;4093.058596522757;4093.918121637491;5936.614120082181;6075.7569697213385;6102.4507794298725;6113.5414843886;6122.602030867979;5787.884242315215;5839.795607153729;5850.94149058521;5902.61632993854;5911.172435859069;5835.708214589169;5870.53035757147;5881.264841894763;5886.764529418775;5889.793857214977;5643.858903527444;5736.770529178786;5742.109972954198;5744.425557444222;5750.568707346882;5822.505087067478;5866.882662346644;5921.289445266596;5929.407059294036;5936.614120082181;5682.06245969427;5685.71571421419;5726.885462290814;5738.368779434342;5741.282339707536 13:26:50 INFO - 2015-12-04 13:26:50,249 DEBUG : BROWSER_OUTPUT: |5;yui.html;730.2624349407097;769.3921801776597;797.6370751308156;803.2128514056228;808.490650889939;10849.945750271247;10977.451127443635;11171.05046071084;11175.329480231172;11203.83194252086;11812.940935295333;11883.287002779818;11903.7619247615;11915.582954596592;11966.940165299184;792.8572856885759;797.7925739307778;813.5118928642826;814.1288820961573;815.2418251026543;807.8061265296345;807.8424707182102;822.9506229626212;825.5170725125779;826.3348004856089;837.0917554453395;845.1379592815325;847.720252316734;851.6550796927254;853.2917678327004;840.995795021024;844.2359664503634;847.3306088190322;848.1730312944891;851.6848765956573;621.5059028072693;622.393166662505;628.4972022382076;630.3255516597243;632.6141053957128;11962.1626486146;11980.400979950968;12017.879821201763;12057.819132713017;12101.818472722829;11323;11721.648350549498;11754.118441116865;11823.704407389798;12000.339981301026;9744.366616169926;9809.460479673615;9853;9909.108180263738;10078.546465409074;3265.755068369882;3278.96721032789;3298.191942973987;3336.2660214752714;3381.2730262993327;36052.278954421025;36066.63933360659;36281.45577816335;36807.07982300464;36921.81539092314;9050.456972581535;9126.771830704152;9169.816603667889;9180.954095229481;9181.265498760084;15408.22958852053;15663.216839157996;15717.921410392875;15730.370785168694;15761.133137677538;6431.324710905287;6480.060391243243;6577.572457790228;6601.174853143357;6612.338766123446;3603.3153700796765;3603.4054381027363;3635.9091022724115;3654.214343916071;3670.339338918967;2788.804783665124;2792.1623512946035;2803.2010876899985;2803.3972695870484;2815.81697189682;497.6118627470579;509.72474863573996;513.6276199755222;517.6919732759002;520.5185203686575;538.6310377391421;592.4016743089511;592.5970340168726;604.3865476541314;644.0725355488082;7711.190325015793;7737.729179478692;7784.377249820114;7914.802129946797;8008.079070906921;504.87630530520255;560.7224423910191;624.35691238024;624.887520246351;643.2120652201016;3640.1445660269815;3690.612485689018;3782.0733920189728;3829.4447305141157;3895.2599006188734;47393;47491;48104;48131.27803082956;48244.27633585499;43253;43427.13145737068;44503.33245001327;44561.77719111449;44721.55278447239;39396.212075758325;39800;40079.39880901789;40164.59835401609;40299;7849.007226479411;7856.764297071097;8230.259276664889;8253.711120110767;8288.783313331198;31132.22169445782;31175.37649246957;31221.219469512536;31743.74035541802;32316;36376.81811590925;36545.45181822222;38614.4207836877;40579.1884162321;40757.38863916984;9299;10096.444695541815;10159.695209143738;10266.743331416475;10382.3251488653;11286.322820630789;11491.310521368745;11736.941315293368;12065.577704780291;12068.879311206776;10856.363861692898;11111.944440277746;11176.497057632263;11188.83216751733;11216.775664486828;9999.250056245955;10241;10345.224108192066;10581.841272381074;11110.277831940897;10231.13035392;10286.125679317043;10364.481775911023;10649.094826939487;11292.378919159524;9040.215701949895;9337.906620933976;9399.34204605671;9575.09036641518;9653.324267301221;8913;9197.586108625263;9455.952720236355;9527.523623818643;9633.277504187354 13:26:50 INFO - 2015-12-04 13:26:50,249 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:26:50 INFO - 2015-12-04 13:26:50,249 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:26:50 INFO - 2015-12-04 13:26:50,249 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,333 13:26:50 INFO - 2015-12-04 13:26:50,249 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:26:50 INFO - 2015-12-04 13:26:50,249 DEBUG : BROWSER_OUTPUT: __startTimestamp1449264410234__endTimestamp 13:26:50 INFO - 2015-12-04 13:26:50,249 DEBUG : BROWSER_OUTPUT: 13:26:50 INFO - 2015-12-04 13:26:50,249 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:26:50 INFO - 2015-12-04 13:26:50,250 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:26:50 INFO - 2015-12-04 13:26:50,250 DEBUG : BROWSER_OUTPUT: 13:26:50 INFO - 2015-12-04 13:26:50,250 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4681.81 Median:4822.76 stddev:490.88 (10.2%) stddev-sans-first:465.93 13:26:50 INFO - 2015-12-04 13:26:50,251 DEBUG : BROWSER_OUTPUT: Values: 2655.5 2699.6 2716.8 2721.0 2736.0 4664.3 4738.1 4755.7 4788.0 4829.4 4645.9 4727.3 4756.4 4773.4 4777.4 4360.7 4395.9 4419.2 4431.6 4437.0 4365.8 4401.3 4406.6 4407.5 4419.4 4199.4 4224.3 4347.0 4359.6 4415.2 4391.1 4399.9 4407.2 4417.2 4442.4 4142.7 4381.8 4387.0 4396.8 4435.7 4538.8 4574.1 4680.0 4706.2 4709.6 5049.2 5081.4 5127.6 5127.8 5144.9 4950.9 5088.0 5139.8 5167.0 5198.0 4582.2 4689.7 4713.9 4722.6 4750.9 5224.9 5254.6 5258.8 5270.2 5310.0 4789.4 4880.7 5054.7 5055.1 5058.6 5006.5 5069.5 5075.3 5082.8 5143.1 4950.4 4998.5 5001.4 5010.2 5016.1 4829.4 4881.7 4948.6 4950.0 4972.2 4211.9 4225.3 4240.0 4247.7 4257.1 3693.2 3702.0 3716.3 3752.4 3753.8 4242.1 4354.0 4361.8 4406.1 4463.8 5123.8 5125.1 5132.1 5145.4 5171.2 4420.0 4422.1 4423.4 4428.6 4453.8 4290.4 4379.3 4404.3 4458.3 4501.1 4782.5 4816.9 4850.6 4852.7 4874.8 4843.8 4988.2 5055.5 5061.2 5129.4 4738.5 4745.9 4822.8 4828.3 4864.5 4978.6 5005.5 5036.1 5063.9 5079.4 4904.5 5044.5 5096.1 5108.1 5141.6 4866.0 4938.4 4942.8 4947.6 4985.7 4913.8 4936.9 4939.2 4954.8 4989.5 4629.5 4672.7 4740.7 4833.0 4892.6 5005.6 5045.9 5051.5 5060.2 5060.7 4898.8 4926.0 4928.9 4943.3 4961.9 13:26:50 INFO - 2015-12-04 13:26:50,251 DEBUG : BROWSER_OUTPUT: 13:26:50 INFO - 2015-12-04 13:26:50,251 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40105.59 Median:18105.85 stddev:63805.37 (352.4%) stddev-sans-first:63915.17 13:26:50 INFO - 2015-12-04 13:26:50,251 DEBUG : BROWSER_OUTPUT: Values: 532.1 568.1 579.3 591.1 598.6 33648.3 34111.5 34164.5 34191.0 34361.5 39647.0 40315.6 40472.2 40656.4 40753.6 7954.8 8176.6 8177.6 8184.3 8187.4 7937.6 8023.5 8037.7 8043.6 8049.3 7946.2 7996.5 8013.2 8032.4 8045.9 8026.4 8055.7 8090.8 8097.6 8112.9 7918.5 7965.2 8020.6 8029.3 8040.9 37013.0 37464.0 37552.0 37614.0 37645.4 2873.0 2902.3 2950.1 3088.2 3321.5 27470.9 28288.9 28352.4 28428.3 28566.4 3199.9 3234.7 3270.7 3272.3 3300.2 209722.0 210662.0 210813.0 211263.9 212244.0 54028.5 54408.5 54439.7 54476.0 54514.0 49234.0 50031.2 57914.0 59497.4 59781.7 12833.2 12861.7 12868.2 12878.2 12973.3 10272.9 10557.7 10593.8 10595.7 10648.1 19053.0 19470.0 19678.2 19700.0 19786.9 7478.7 7694.2 7819.8 7836.3 7853.0 833.0 900.5 912.2 922.5 929.8 25940.0 26232.7 26302.7 26412.6 26443.3 937.7 971.2 977.2 1054.8 1138.1 13711.3 13823.0 13906.4 13950.2 14006.9 271256.0 273041.0 273062.0 273956.0 274744.0 44302.0 44379.8 44569.8 44995.8 45026.1 1205.4 1213.5 1214.2 1239.2 1246.4 24753.0 25767.9 25860.6 26304.3 26490.3 40358.2 40817.0 40856.2 40859.8 40900.0 244608.0 245650.0 246218.0 247670.0 248136.0 25642.5 26553.6 28611.7 29859.7 30854.0 34498.0 34947.8 34967.5 35063.3 37829.8 29919.7 30158.4 30220.4 30295.0 30510.5 32387.5 32397.0 32429.5 33018.8 33491.3 32426.8 32909.5 32911.5 33078.8 33922.0 26233.9 27336.0 28106.2 28118.0 28440.0 22994.3 23513.9 23797.2 23863.9 24044.5 13:26:50 INFO - 2015-12-04 13:26:50,252 DEBUG : BROWSER_OUTPUT: 13:26:50 INFO - 2015-12-04 13:26:50,252 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26297.80 Median:2186.81 stddev:81816.82 (3741.4%) stddev-sans-first:82023.11 13:26:50 INFO - 2015-12-04 13:26:50,253 DEBUG : BROWSER_OUTPUT: Values: 332.7 332.8 334.8 335.9 337.5 15030.3 15561.8 15882.4 16098.8 16725.3 9431.9 9486.8 9527.1 9670.3 9865.8 4407.2 4522.6 4548.7 4560.9 4570.2 4485.9 4855.8 5037.1 5037.9 5044.8 3366.3 3447.3 5007.8 5027.6 5117.7 5169.3 5203.1 5212.5 5227.7 5258.9 4842.2 4854.3 4874.6 5055.1 5065.4 11021.1 11024.1 11202.3 11412.8 19435.5 1852.9 1892.6 1920.6 1942.9 1989.6 8903.0 10236.5 12427.8 12778.1 13002.8 1735.4 1740.5 1770.7 1806.3 1826.3 55797.4 56249.2 56775.4 56938.4 57277.4 9493.9 9691.1 9769.2 9834.0 9916.4 11628.6 11646.8 11690.0 11728.6 11750.0 6792.4 6905.8 6969.7 7071.9 7131.0 6396.7 6437.6 6477.4 6484.8 6516.0 3925.4 3978.5 4187.0 4203.3 4227.2 1667.8 1673.5 1690.3 1726.1 1743.5 363.2 370.7 372.8 890.6 903.4 9524.3 9635.5 9686.1 9787.1 9840.8 376.8 382.5 382.8 384.5 395.1 3868.0 5264.7 5316.0 5363.6 5391.7 493783.0 495381.0 497579.0 506818.0 507515.0 70468.6 71306.6 72501.6 74470.6 76798.6 1031.8 1062.5 1062.8 1063.3 1073.7 14810.3 14855.1 14949.5 14967.6 15230.0 32478.8 33203.7 33320.3 34166.3 34592.0 42727.6 43439.8 44883.3 45024.5 45268.8 8005.8 8330.2 8341.9 8388.0 8475.7 15766.0 15906.7 16008.0 16177.6 17035.7 13926.1 14034.9 14134.2 14405.9 14411.7 12262.6 13378.0 13742.3 13969.4 14392.4 14464.8 14600.6 14721.3 14777.9 14935.2 8375.4 8394.8 8407.3 8432.5 8441.0 10925.7 14119.1 14135.3 14155.6 14221.9 13:26:50 INFO - 2015-12-04 13:26:50,253 DEBUG : BROWSER_OUTPUT: 13:26:50 INFO - 2015-12-04 13:26:50,253 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4970.76 Median:6326.25 stddev:2576.91 (40.7%) stddev-sans-first:2570.53 13:26:50 INFO - 2015-12-04 13:26:50,254 DEBUG : BROWSER_OUTPUT: Values: 1447.3 1634.7 1679.2 1702.3 1706.1 6333.6 6435.7 6907.3 7268.6 7324.1 6947.2 7177.4 7234.8 7246.8 7291.0 2084.3 2090.4 2127.7 2128.9 2129.6 2081.0 2092.5 2095.1 2115.9 2126.5 2061.6 2073.3 2087.3 2090.5 2092.0 2065.6 2085.9 2088.3 2088.9 2091.4 2056.1 2087.0 2088.6 2093.8 2099.6 7051.4 7147.6 7162.8 7163.4 7176.2 4071.0 4117.3 4147.6 4160.5 4169.5 2319.2 2380.1 2686.4 2699.4 2700.1 836.3 873.9 893.4 904.1 911.7 9468.0 9554.7 9579.0 9586.9 9598.7 3840.9 3931.5 3932.2 3952.3 3965.6 8383.3 8396.0 8405.2 8419.9 8422.0 4225.9 4248.0 4250.5 4260.0 4266.3 3803.7 3840.7 3868.4 3869.9 3871.4 3335.8 3384.4 3392.2 3426.9 3436.8 1089.6 1105.2 1106.6 1110.5 1120.6 1123.0 1184.8 1197.7 1200.8 1224.2 6825.1 6840.3 6932.3 6939.0 6939.6 400.9 408.9 412.8 413.6 415.0 5320.7 5344.5 5360.9 5423.9 5425.0 7580.2 7778.3 8412.8 8560.3 8569.4 8338.3 8342.2 8378.8 8389.8 8457.1 6531.5 6545.4 6558.7 6682.2 6791.9 6380.7 6411.9 6421.9 6429.9 6437.1 7417.3 7420.3 7582.7 7631.8 7638.3 7717.9 7813.8 7911.7 7928.7 7995.3 6318.9 6336.9 6352.4 6368.3 6431.9 6650.9 6691.0 6726.5 6741.3 6752.9 6364.0 6401.0 6449.2 6510.2 6548.4 6425.4 6434.9 6473.1 6495.2 6512.4 6553.8 6616.9 6619.7 6624.9 6641.9 5936.4 6037.7 6050.5 6062.5 6078.0 6021.2 6046.1 6115.9 6120.7 6157.5 13:26:50 INFO - 2015-12-04 13:26:50,254 DEBUG : BROWSER_OUTPUT: 13:26:50 INFO - 2015-12-04 13:26:50,255 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4818.79 Median:5545.42 stddev:1446.47 (26.1%) stddev-sans-first:1410.18 13:26:50 INFO - 2015-12-04 13:26:50,255 DEBUG : BROWSER_OUTPUT: Values: 298.4 302.3 306.9 309.6 310.5 5441.4 5469.1 5548.2 5575.8 5638.2 5369.3 5542.6 5551.9 5555.6 5579.7 4272.6 4280.0 4284.6 4293.5 4294.6 4287.1 4293.8 4299.3 4303.5 4304.8 4057.2 4203.9 4262.6 4265.5 4268.3 4193.1 4194.5 4194.6 4197.5 4219.2 3663.8 3672.0 3673.6 3676.8 3681.8 5230.7 5235.5 5236.8 5267.4 5291.8 4789.4 4790.1 4825.7 4834.5 4843.1 5633.3 5839.5 5840.9 5845.3 5857.6 3972.9 3973.3 3974.1 3978.3 3980.4 6097.6 6127.2 6145.1 6155.6 6171.4 3923.4 4104.8 4116.2 4121.9 4130.4 4064.9 4078.9 4080.8 4098.4 4104.0 4706.2 4711.2 4714.5 4730.1 4734.1 5734.6 5805.9 5809.0 5809.3 5809.9 1435.7 1438.8 1460.8 1469.8 1475.9 962.6 986.2 987.3 1002.2 1002.5 5000.3 5001.2 5004.9 5044.2 5059.4 5989.0 5998.3 6003.5 6011.3 6017.2 5023.5 5045.2 5049.9 5060.2 5068.4 3198.3 3237.3 3269.3 3271.6 3308.1 5776.8 5790.6 5826.7 5830.5 5831.9 6273.2 6312.2 6322.1 6331.8 6344.5 5670.3 5697.8 5767.4 5786.6 5824.7 6106.9 6108.4 6118.4 6126.2 6148.4 5975.9 5990.3 5990.4 5996.8 5997.8 5811.4 5816.1 5824.9 5825.2 5826.4 3978.7 4052.0 4092.0 4093.1 4093.9 5936.6 6075.8 6102.5 6113.5 6122.6 5787.9 5839.8 5850.9 5902.6 5911.2 5835.7 5870.5 5881.3 5886.8 5889.8 5643.9 5736.8 5742.1 5744.4 5750.6 5822.5 5866.9 5921.3 5929.4 5936.6 5682.1 5685.7 5726.9 5738.4 5741.3 13:26:50 INFO - 2015-12-04 13:26:50,255 DEBUG : BROWSER_OUTPUT: 13:26:50 INFO - 2015-12-04 13:26:50,255 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12080.09 Median:43965.23 stddev:13311.46 (30.3%) stddev-sans-first:13321.51 13:26:50 INFO - 2015-12-04 13:26:50,255 DEBUG : BROWSER_OUTPUT: Values: 730.3 769.4 797.6 803.2 808.5 10849.9 10977.5 11171.1 11175.3 11203.8 11812.9 11883.3 11903.8 11915.6 11966.9 792.9 797.8 813.5 814.1 815.2 807.8 807.8 823.0 825.5 826.3 837.1 845.1 847.7 851.7 853.3 841.0 844.2 847.3 848.2 851.7 621.5 622.4 628.5 630.3 632.6 11962.2 11980.4 12017.9 12057.8 12101.8 11323.0 11721.6 11754.1 11823.7 12000.3 9744.4 9809.5 9853.0 9909.1 10078.5 3265.8 3279.0 3298.2 3336.3 3381.3 36052.3 36066.6 36281.5 36807.1 36921.8 9050.5 9126.8 9169.8 9181.0 9181.3 15408.2 15663.2 15717.9 15730.4 15761.1 6431.3 6480.1 6577.6 6601.2 6612.3 3603.3 3603.4 3635.9 3654.2 3670.3 2788.8 2792.2 2803.2 2803.4 2815.8 497.6 509.7 513.6 517.7 520.5 538.6 592.4 592.6 604.4 644.1 7711.2 7737.7 7784.4 7914.8 8008.1 504.9 560.7 624.4 624.9 643.2 3640.1 3690.6 3782.1 3829.4 3895.3 47393.0 47491.0 48104.0 48131.3 48244.3 43253.0 43427.1 44503.3 44561.8 44721.6 39396.2 39800.0 40079.4 40164.6 40299.0 7849.0 7856.8 8230.3 8253.7 8288.8 31132.2 31175.4 31221.2 31743.7 32316.0 36376.8 36545.5 38614.4 40579.2 40757.4 9299.0 10096.4 10159.7 10266.7 10382.3 11286.3 11491.3 11736.9 12065.6 12068.9 10856.4 11111.9 11176.5 11188.8 11216.8 9999.3 10241.0 10345.2 10581.8 11110.3 10231.1 10286.1 10364.5 10649.1 11292.4 9040.2 9337.9 9399.3 9575.1 9653.3 8913.0 9197.6 9456.0 9527.5 9633.3 13:26:50 INFO - 2015-12-04 13:26:50,255 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:26:50 INFO - 2015-12-04 13:26:50,255 DEBUG : BROWSER_OUTPUT: 13:26:50 INFO - 2015-12-04 13:26:50,961 INFO : Browser exited with error code: 0 13:26:50 INFO - 2015-12-04 13:26:50,977 INFO : Completed test dromaeo_css (00:18:37) 13:26:50 INFO - 2015-12-04 13:26:50,978 INFO : Starting test kraken 13:26:50 INFO - 2015-12-04 13:26:50,978 DEBUG : operating with platform_type : linux_ 13:26:50 INFO - 2015-12-04 13:26:50,978 INFO : Initialising browser for kraken test... 13:26:50 INFO - 2015-12-04 13:26:50,984 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboC0uO/profile http://localhost:40702/getInfo.html 13:26:54 INFO - 2015-12-04 13:26:54,577 DEBUG : BROWSER_OUTPUT: console.error: 13:26:54 INFO - 2015-12-04 13:26:54,577 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:26:54 INFO - 2015-12-04 13:26:54,577 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:26:55 INFO - 2015-12-04 13:26:55,832 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:26:55 INFO - 2015-12-04 13:26:55,832 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:26:55 INFO - 2015-12-04 13:26:55,832 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:26:55 INFO - 2015-12-04 13:26:55,833 DEBUG : BROWSER_OUTPUT: __metrics 13:26:55 INFO - 2015-12-04 13:26:55,981 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] 13:26:56 INFO - 2015-12-04 13:26:56,905 INFO : Browser initialized. 13:26:56 INFO - 2015-12-04 13:26:56,906 INFO : Running cycle 1/1 for kraken test... 13:26:56 INFO - 2015-12-04 13:26:56,906 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpboC0uO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:26:58 INFO - 2015-12-04 13:26:58,600 DEBUG : BROWSER_OUTPUT: console.error: 13:26:58 INFO - 2015-12-04 13:26:58,600 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:26:58 INFO - 2015-12-04 13:26:58,600 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:27:08 INFO - 2015-12-04 13:27:08,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 141836288 13:27:08 INFO - 2015-12-04 13:27:08,971 DEBUG : BROWSER_OUTPUT: 13:27:11 INFO - 2015-12-04 13:27:11,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40702/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:12 INFO - 2015-12-04 13:27:12,170 DEBUG : BROWSER_OUTPUT: RSS: Main: 141873152 13:27:12 INFO - 2015-12-04 13:27:12,170 DEBUG : BROWSER_OUTPUT: 13:27:14 INFO - 2015-12-04 13:27:14,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40702/tests/kraken/driver.html?testName=audio-dft) 13:27:15 INFO - 2015-12-04 13:27:15,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 142843904 13:27:15 INFO - 2015-12-04 13:27:15,509 DEBUG : BROWSER_OUTPUT: 13:27:18 INFO - 2015-12-04 13:27:18,409 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40702/tests/kraken/driver.html?testName=audio-fft) 13:27:18 INFO - 2015-12-04 13:27:18,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 138022912 13:27:18 INFO - 2015-12-04 13:27:18,995 DEBUG : BROWSER_OUTPUT: 13:27:21 INFO - 2015-12-04 13:27:21,059 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40702/tests/kraken/driver.html?testName=audio-oscillator) 13:27:21 INFO - 2015-12-04 13:27:21,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 138489856 13:27:21 INFO - 2015-12-04 13:27:21,682 DEBUG : BROWSER_OUTPUT: 13:27:23 INFO - 2015-12-04 13:27:23,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40702/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:27:24 INFO - 2015-12-04 13:27:24,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 140058624 13:27:24 INFO - 2015-12-04 13:27:24,523 DEBUG : BROWSER_OUTPUT: 13:27:27 INFO - 2015-12-04 13:27:27,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40702/tests/kraken/driver.html?testName=imaging-darkroom) 13:27:28 INFO - 2015-12-04 13:27:28,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 140607488 13:27:28 INFO - 2015-12-04 13:27:28,209 DEBUG : BROWSER_OUTPUT: 13:27:31 INFO - 2015-12-04 13:27:31,660 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40702/tests/kraken/driver.html?testName=imaging-desaturate) 13:27:32 INFO - 2015-12-04 13:27:32,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 140578816 13:27:32 INFO - 2015-12-04 13:27:32,267 DEBUG : BROWSER_OUTPUT: 13:27:35 INFO - 2015-12-04 13:27:35,165 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40702/tests/kraken/driver.html?testName=json-parse-financial) 13:27:35 INFO - 2015-12-04 13:27:35,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 141053952 13:27:35 INFO - 2015-12-04 13:27:35,754 DEBUG : BROWSER_OUTPUT: 13:27:37 INFO - 2015-12-04 13:27:37,524 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40702/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:27:38 INFO - 2015-12-04 13:27:38,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 141180928 13:27:38 INFO - 2015-12-04 13:27:38,110 DEBUG : BROWSER_OUTPUT: 13:27:40 INFO - 2015-12-04 13:27:40,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40702/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:27:40 INFO - 2015-12-04 13:27:40,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 141455360 13:27:40 INFO - 2015-12-04 13:27:40,627 DEBUG : BROWSER_OUTPUT: 13:27:42 INFO - 2015-12-04 13:27:42,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40702/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:27:43 INFO - 2015-12-04 13:27:43,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 141369344 13:27:43 INFO - 2015-12-04 13:27:43,382 DEBUG : BROWSER_OUTPUT: 13:27:45 INFO - 2015-12-04 13:27:45,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:27:46 INFO - 2015-12-04 13:27:46,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 140947456 13:27:46 INFO - 2015-12-04 13:27:46,562 DEBUG : BROWSER_OUTPUT: 13:27:49 INFO - 2015-12-04 13:27:49,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:27:49 INFO - 2015-12-04 13:27:49,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 140206080 13:27:49 INFO - 2015-12-04 13:27:49,733 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40702/tests/kraken/driver.html?testName=ai-astar) 13:27:51 INFO - 2015-12-04 13:27:51,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 140677120 13:27:51 INFO - 2015-12-04 13:27:51,757 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,757 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:27:51 INFO - 2015-12-04 13:27:51,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:27:51 INFO - 2015-12-04 13:27:51,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:27:51 INFO - 2015-12-04 13:27:51,758 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:27:51 INFO - 2015-12-04 13:27:51,758 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;108;110;112;111;125;110;112;110;111 13:27:51 INFO - 2015-12-04 13:27:51,758 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;130;153;159;137;167;165;130;172;131 13:27:51 INFO - 2015-12-04 13:27:51,758 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;164;164;161;165;163;164;164;163;162 13:27:51 INFO - 2015-12-04 13:27:51,758 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;73;72;74;87;139;72;71;72 13:27:51 INFO - 2015-12-04 13:27:51,758 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;130;93;94;93;134;93;94;131 13:27:51 INFO - 2015-12-04 13:27:51,758 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;110;110;109;110;110;110 13:27:51 INFO - 2015-12-04 13:27:51,759 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;147;147;148;147;148;147;148;150 13:27:51 INFO - 2015-12-04 13:27:51,759 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;100;97;96;96;96;96;102;96;95 13:27:51 INFO - 2015-12-04 13:27:51,759 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;73;73;76;74;73;72;75;71 13:27:51 INFO - 2015-12-04 13:27:51,759 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;76;68;69;68;69;68;69;69;70 13:27:51 INFO - 2015-12-04 13:27:51,759 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;85;83;84;85;96;85;84;87 13:27:51 INFO - 2015-12-04 13:27:51,759 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;126;130;131;131;134;120;124;122;122 13:27:51 INFO - 2015-12-04 13:27:51,759 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;164;136;148;151;147;146;147;139;147 13:27:51 INFO - 2015-12-04 13:27:51,759 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;75;76;68;68;69;71;69 13:27:51 INFO - 2015-12-04 13:27:51,760 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:27:51 INFO - 2015-12-04 13:27:51,760 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:27:51 INFO - 2015-12-04 13:27:51,760 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,787 13:27:51 INFO - 2015-12-04 13:27:51,760 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:27:51 INFO - 2015-12-04 13:27:51,760 DEBUG : BROWSER_OUTPUT: __startTimestamp1449264471756__endTimestamp 13:27:51 INFO - 2015-12-04 13:27:51,760 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:4.70 (4.2%) stddev-sans-first:4.99 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: Values: 112.0 108.0 110.0 112.0 111.0 125.0 110.0 112.0 110.0 111.0 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:159.50 stddev:16.72 (10.5%) stddev-sans-first:17.37 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: Values: 160.0 130.0 153.0 159.0 137.0 167.0 165.0 130.0 172.0 131.0 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.10 Median:164.00 stddev:1.37 (0.8%) stddev-sans-first:1.22 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: Values: 161.0 164.0 164.0 161.0 165.0 163.0 164.0 164.0 163.0 162.0 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,764 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:73.50 stddev:20.96 (28.5%) stddev-sans-first:22.09 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 73.0 72.0 74.0 87.0 139.0 72.0 71.0 72.0 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:93.50 stddev:18.37 (19.6%) stddev-sans-first:19.12 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 130.0 93.0 94.0 93.0 134.0 93.0 94.0 131.0 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 110.0 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.00 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 150.0 13:27:51 INFO - 2015-12-04 13:27:51,765 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.00 stddev:2.21 (2.3%) stddev-sans-first:2.32 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: Values: 96.0 100.0 97.0 96.0 96.0 96.0 96.0 102.0 96.0 95.0 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.00 stddev:1.52 (2.1%) stddev-sans-first:1.56 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 73.0 73.0 76.0 74.0 73.0 72.0 75.0 71.0 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:2.41 (3.5%) stddev-sans-first:2.51 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: Values: 68.0 76.0 68.0 69.0 68.0 69.0 68.0 69.0 69.0 70.0 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:3.73 (4.4%) stddev-sans-first:3.89 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 85.0 83.0 84.0 85.0 96.0 85.0 84.0 87.0 13:27:51 INFO - 2015-12-04 13:27:51,766 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:128.00 stddev:4.70 (3.7%) stddev-sans-first:4.97 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: Values: 126.0 126.0 130.0 131.0 131.0 134.0 120.0 124.0 122.0 122.0 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:147.00 stddev:8.34 (5.7%) stddev-sans-first:7.84 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: Values: 135.0 164.0 136.0 148.0 151.0 147.0 146.0 147.0 139.0 147.0 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.00 stddev:2.94 (4.3%) stddev-sans-first:3.08 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 75.0 76.0 68.0 68.0 69.0 71.0 69.0 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:27:51 INFO - 2015-12-04 13:27:51,767 DEBUG : BROWSER_OUTPUT: 13:27:52 INFO - 2015-12-04 13:27:52,624 INFO : Browser exited with error code: 0 13:27:52 INFO - 2015-12-04 13:27:52,673 INFO : Completed test kraken (00:01:01) 13:27:52 INFO - 2015-12-04 13:27:52,673 INFO : Starting test v8_7 13:27:52 INFO - 2015-12-04 13:27:52,673 DEBUG : operating with platform_type : linux_ 13:27:52 INFO - 2015-12-04 13:27:52,673 INFO : Initialising browser for v8_7 test... 13:27:52 INFO - 2015-12-04 13:27:52,679 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbOMYtL/profile http://localhost:40702/getInfo.html 13:27:56 INFO - 2015-12-04 13:27:56,316 DEBUG : BROWSER_OUTPUT: console.error: 13:27:56 INFO - 2015-12-04 13:27:56,316 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:27:56 INFO - 2015-12-04 13:27:56,316 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:27:57 INFO - 2015-12-04 13:27:57,590 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:27:57 INFO - 2015-12-04 13:27:57,590 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:27:57 INFO - 2015-12-04 13:27:57,590 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:27:57 INFO - 2015-12-04 13:27:57,590 DEBUG : BROWSER_OUTPUT: __metrics 13:27:57 INFO - 2015-12-04 13:27:57,727 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] 13:27:58 INFO - 2015-12-04 13:27:58,597 INFO : Browser initialized. 13:27:58 INFO - 2015-12-04 13:27:58,598 INFO : Running cycle 1/1 for v8_7 test... 13:27:58 INFO - 2015-12-04 13:27:58,598 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbOMYtL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:28:00 INFO - 2015-12-04 13:28:00,252 DEBUG : BROWSER_OUTPUT: console.error: 13:28:00 INFO - 2015-12-04 13:28:00,252 DEBUG : BROWSER_OUTPUT: [CustomizableUI] 13:28:00 INFO - 2015-12-04 13:28:00,252 DEBUG : BROWSER_OUTPUT: Custom widget with id loop-button does not return a valid node 13:28:10 INFO - 2015-12-04 13:28:10,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 143986688 13:28:10 INFO - 2015-12-04 13:28:10,589 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,084 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40702/tests/v8_7/run.html (next: http://localhost:40702/tests/v8_7/run.html) 13:28:32 INFO - 2015-12-04 13:28:32,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 137969664 13:28:32 INFO - 2015-12-04 13:28:32,334 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,335 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:28:32 INFO - 2015-12-04 13:28:32,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:28:32 INFO - 2015-12-04 13:28:32,336 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:28:32 INFO - 2015-12-04 13:28:32,336 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:28:32 INFO - 2015-12-04 13:28:32,336 DEBUG : BROWSER_OUTPUT: |0;Richards;166.25103906899417 13:28:32 INFO - 2015-12-04 13:28:32,336 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.0264998159735 13:28:32 INFO - 2015-12-04 13:28:32,336 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 13:28:32 INFO - 2015-12-04 13:28:32,336 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 13:28:32 INFO - 2015-12-04 13:28:32,336 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1061.5058324496288 13:28:32 INFO - 2015-12-04 13:28:32,337 DEBUG : BROWSER_OUTPUT: |5;Earley;702.2471910112359 13:28:32 INFO - 2015-12-04 13:28:32,337 DEBUG : BROWSER_OUTPUT: |6;Boyer;12096.385542168675 13:28:32 INFO - 2015-12-04 13:28:32,337 DEBUG : BROWSER_OUTPUT: |7;RegExp;25871.79487179487 13:28:32 INFO - 2015-12-04 13:28:32,337 DEBUG : BROWSER_OUTPUT: |8;Splay;652.2301228183582 13:28:32 INFO - 2015-12-04 13:28:32,337 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 13:28:32 INFO - 2015-12-04 13:28:32,337 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:28:32 INFO - 2015-12-04 13:28:32,338 DEBUG : BROWSER_OUTPUT: __startTimestamp1449264512334__endTimestamp 13:28:32 INFO - 2015-12-04 13:28:32,338 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,338 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:28:32 INFO - 2015-12-04 13:28:32,338 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:28:32 INFO - 2015-12-04 13:28:32,338 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,339 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,339 DEBUG : BROWSER_OUTPUT: Values: 166.3 13:28:32 INFO - 2015-12-04 13:28:32,339 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,340 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.03 Median:184.03 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,340 DEBUG : BROWSER_OUTPUT: Values: 184.0 13:28:32 INFO - 2015-12-04 13:28:32,341 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,341 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,341 DEBUG : BROWSER_OUTPUT: Values: 278.2 13:28:32 INFO - 2015-12-04 13:28:32,341 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,341 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,341 DEBUG : BROWSER_OUTPUT: Values: 5181.3 13:28:32 INFO - 2015-12-04 13:28:32,341 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,342 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1061.51 Median:1061.51 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,342 DEBUG : BROWSER_OUTPUT: Values: 1061.5 13:28:32 INFO - 2015-12-04 13:28:32,342 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,342 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:702.25 Median:702.25 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,342 DEBUG : BROWSER_OUTPUT: Values: 702.2 13:28:32 INFO - 2015-12-04 13:28:32,342 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,342 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12096.39 Median:12096.39 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,342 DEBUG : BROWSER_OUTPUT: Values: 12096.4 13:28:32 INFO - 2015-12-04 13:28:32,343 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,343 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25871.79 Median:25871.79 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,343 DEBUG : BROWSER_OUTPUT: Values: 25871.8 13:28:32 INFO - 2015-12-04 13:28:32,343 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,343 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:652.23 Median:652.23 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,343 DEBUG : BROWSER_OUTPUT: Values: 652.2 13:28:32 INFO - 2015-12-04 13:28:32,343 DEBUG : BROWSER_OUTPUT: 13:28:32 INFO - 2015-12-04 13:28:32,344 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 13:28:32 INFO - 2015-12-04 13:28:32,344 DEBUG : BROWSER_OUTPUT: Values: 4830.9 13:28:32 INFO - 2015-12-04 13:28:32,344 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:28:32 INFO - 2015-12-04 13:28:32,344 DEBUG : BROWSER_OUTPUT: 13:28:33 INFO - 2015-12-04 13:28:33,245 INFO : Browser exited with error code: 0 13:28:33 INFO - 2015-12-04 13:28:33,260 INFO : Completed test v8_7 (00:00:40) 13:28:33 INFO - 2015-12-04 13:28:33,298 INFO : Completed test suite (00:20:19) 13:28:33 INFO - 2015-12-04 13:28:33,298 DEBUG : Working with test: dromaeo_css 13:28:33 INFO - 2015-12-04 13:28:33,298 DEBUG : Generating results file: dromaeo_css 13:28:33 INFO - 2015-12-04 13:28:33,299 DEBUG : Working with test: kraken 13:28:33 INFO - 2015-12-04 13:28:33,299 DEBUG : Generating results file: kraken 13:28:33 INFO - 2015-12-04 13:28:33,300 INFO : javascript benchmark 13:28:33 INFO - 2015-12-04 13:28:33,300 DEBUG : Working with test: v8_7 13:28:33 INFO - 2015-12-04 13:28:33,300 DEBUG : Generating results file: v8_7 13:28:33 INFO - 2015-12-04 13:28:33,300 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:28:33 INFO - 2015-12-04 13:28:33,355 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 13:28:33 INFO - 2015-12-04 13:28:33,355 DEBUG : process_Request line: dromaeo_css 6251.76 graph.html#tests=[[72,132,43]] 13:28:33 INFO - 2015-12-04 13:28:33,355 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:28:33 INFO - 2015-12-04 13:28:33,388 DEBUG : process_Request line: kraken 1537.50 graph.html#tests=[[232,132,43]] 13:28:33 INFO - 2015-12-04 13:28:33,388 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:28:33 INFO - 2015-12-04 13:28:33,419 DEBUG : process_Request line: v8_7 21302.24 graph.html#tests=[[230,132,43]] 13:28:33 INFO - 2015-12-04 13:28:33,421 INFO : javascript benchmark 13:28:33 INFO - 2015-12-04 13:28:33,424 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2655.4821809747095, 2699.5545734953735, 2716.782657387409, 2721.034032918315, 2735.9589606155905, 4664.323673067403, 4738.123447162273, 4755.667103302771, 4788.0, 4829.396325459317, 4645.930311045328, 4727.290906364047, 4756.429228492577, 4773.403324584427, 4777.378940737708, 4360.738355698668, 4395.912081758363, 4419.248727716296, 4431.64546836254, 4437.0, 4365.847195348163, 4401.339799030139, 4406.5593440656, 4407.537208593099, 4419.447569053868, 4199.370094485821, 4224.345226489899, 4346.978265108686, 4359.607635312837, 4415.183191109639, 4391.077873646506, 4399.934000989988, 4407.206702793496, 4417.249067658506, 4442.400275962736, 4142.689298302609, 4381.802818873159, 4387.0, 4396.824127034914, 4435.667324950609, 4538.818447262105, 4574.130915126116, 4680.040591678731, 4706.176419126639, 4709.599684026862, 5049.242613607951, 5081.415637201732, 5127.6154288428515, 5127.8205262816, 5144.871378215575, 4950.925736113961, 5087.974560127176, 5139.8458046258675, 5166.974165129188, 5198.0, 4582.175208462475, 4689.695169813951, 4713.905721885543, 4722.6221902247735, 4750.857474275777, 5224.92162617561, 5254.632175747737, 5258.789648414021, 5270.235815806686, 5310.0, 4789.449213340441, 4880.731559764247, 5054.671446355975, 5055.064813009605, 5058.620603454756, 5006.524380183877, 5069.518395752398, 5075.3402057732255, 5082.847514574569, 5143.12566863634, 4950.36637909489, 4998.500149985045, 5001.424836143818, 5010.198368261061, 5016.1221786188, 4829.420469543677, 4881.658283920163, 4948.617780984818, 4949.950500494949, 4972.154733695281, 4211.873643790691, 4225.323948168279, 4239.97880010598, 4247.660187185018, 4257.063446041866, 3693.224422871227, 3701.9629803702155, 3716.2939041582013, 3752.3620984432714, 3753.774773513598, 4242.109157076987, 4354.020345422318, 4361.847335343247, 4406.1187762447635, 4463.843765468193, 5123.769430375642, 5125.077486052472, 5132.050570644443, 5145.408278047998, 5171.198464238049, 4419.9779001105435, 4422.115576884636, 4423.358613001097, 4428.557144285545, 4453.755043472575, 4290.399344091829, 4379.321205213197, 4404.339349097597, 4458.286674132188, 4501.0547784964865, 4782.497837726988, 4816.8795780105775, 4850.563449289581, 4852.708837469763, 4874.756262186947, 4843.782029808596, 4988.152014157675, 5055.494450555062, 5061.215511595708, 5129.358830146231, 4738.549837765407, 4745.9050818984115, 4822.758862056813, 4828.251620998751, 4864.464908859952, 4978.626603004862, 5005.549500544968, 5036.093503169464, 5063.87340316495, 5079.390473143247, 4904.509549045067, 5044.47033061538, 5096.133657278346, 5108.131617625087, 5141.614378921521, 4866.0, 4938.407391113089, 4942.827001054946, 4947.604191664586, 4985.675931064469, 4913.754312284443, 4936.925946110883, 4939.209726443752, 4954.752262386794, 4989.525995030466, 4629.4676112247525, 4672.696274742131, 4740.6681532292405, 4832.95167048325, 4892.608591312757, 5005.649604527648, 5045.949540504548, 5051.4695956924, 5060.2156665716875, 5060.746962651926, 4898.804047838189, 4925.950740492693, 4928.890999525078, 4943.332650092191, 4961.875953101201], "unit": "ms", "name": "dojo.html", "value": 4651.136824099908}, {"lowerIsBetter": false, "replicates": [532.0831775432137, 568.1449418624969, 579.333766168906, 591.1074277840461, 598.6049207523034, 33648.32703345932, 34111.488327675106, 34164.487532686966, 34191.0, 34361.48457773135, 39647.0, 40315.59684403155, 40472.190556188856, 40656.39015414771, 40753.59246407535, 7954.801129971754, 8176.550289734062, 8177.5911204439835, 8184.304334131606, 8187.38594605404, 7937.642806073741, 8023.518588884656, 8037.718679846206, 8043.638036288381, 8049.315808156313, 7946.16565260648, 7996.520208787462, 8013.198680131969, 8032.3574114071025, 8045.879311810328, 8026.357891368706, 8055.718049868285, 8090.757277281691, 8097.635606397726, 8112.918870811275, 7918.485298455639, 7965.163657815904, 8020.639071241808, 8029.277365037175, 8040.919590804076, 37013.0, 37464.0, 37552.0, 37614.0, 37645.43531847024, 2872.971270287291, 2902.324841713972, 2950.0707277207825, 3088.243380371801, 3321.501774733785, 27470.862645686644, 28288.858555707295, 28352.432951341063, 28428.28929276764, 28566.428671426456, 3199.9200019999453, 3234.67653234677, 3270.73834093272, 3272.312814308998, 3300.1914530939835, 209722.0, 210662.0, 210813.0, 211263.94368028216, 212244.0, 54028.45971540313, 54408.45591544034, 54439.72780136074, 54476.0, 54514.0, 49234.0, 50031.24953125706, 57914.0, 59497.405025949185, 59781.70109149513, 12833.230006199658, 12861.678458038437, 12868.22790632565, 12878.162919410208, 12973.286469244282, 10272.948635256776, 10557.736056598493, 10593.788124237471, 10595.735106622396, 10648.148148148284, 19052.952087635313, 19470.0311687796, 19678.212871485266, 19700.0, 19786.90106549458, 7478.663460144307, 7694.192109828499, 7819.765407037798, 7836.294733474015, 7853.018372703412, 832.9791755206169, 900.4642237868458, 912.224609082288, 922.5156792683895, 929.8047410043831, 25940.0, 26232.73767262303, 26302.736972630413, 26412.603810942852, 26443.297938288655, 937.6952490440498, 971.1842052675786, 977.1791694976254, 1054.8048611006989, 1138.123644793521, 13711.314434278445, 13823.0, 13906.374213160432, 13950.162990220619, 14006.929965350108, 271256.0, 273041.0, 273062.0, 273956.0, 274744.0, 44302.0, 44379.778101109936, 44569.77715111404, 44995.77502112468, 45026.099478010256, 1205.445495072259, 1213.5449206547544, 1214.241099312947, 1239.2254840724547, 1246.4141853328922, 24753.0, 25767.871160644827, 25860.612090819028, 26304.34239144037, 26490.337741555843, 40358.1928361437, 40816.97957551085, 40856.182876341714, 40859.79570102131, 40900.0, 244608.0, 245650.0, 246218.0, 247670.0, 248136.0, 25642.48715025652, 26553.60169597419, 28611.71388286174, 29859.70140298569, 30854.0, 34498.0, 34947.825260873535, 34967.475487868214, 35063.29873402569, 37829.81085094557, 29919.700802992564, 30158.396832062797, 30220.395592088476, 30295.0, 30510.542341864446, 32387.51418728674, 32397.0, 32429.51355729713, 33018.834905825315, 33491.33017339591, 32426.83786581052, 32909.50635740418, 32911.506327404626, 33078.834605826814, 33922.0, 26233.868830656487, 27336.0, 28106.156815295573, 28118.0, 28440.0, 22994.250441795324, 23513.88243058774, 23797.167099151447, 23863.880680596485, 24044.51910961806], "unit": "ms", "name": "ext.html", "value": 16683.140047439927}, {"lowerIsBetter": false, "replicates": [332.664009350556, 332.78036495912704, 334.7723547987369, 335.85726066421773, 337.54937158892875, 15030.323635436403, 15561.766573501407, 15882.364705411785, 16098.7585186222, 16725.330986760517, 9431.858522122157, 9486.81026379472, 9527.094925982037, 9670.323077384568, 9865.802683946316, 4407.162639098577, 4522.6155776759015, 4548.681592288541, 4560.8859778505475, 4570.154521413532, 4485.932711009337, 4855.781489832966, 5037.11850426174, 5037.924431133536, 5044.82343117991, 3366.276250606119, 3447.2933048725076, 5007.84976450707, 5027.648064635477, 5117.667351622151, 5169.276301317818, 5203.063448579254, 5212.50481204285, 5227.660202086871, 5258.947410525903, 4842.201036828919, 4854.320395144682, 4874.561289483963, 5055.064813009605, 5065.442801291855, 11021.118310535217, 11024.118070554417, 11202.327860328407, 11412.828807567894, 19435.514112147168, 1852.9166187521594, 1892.5552495163627, 1920.6062757134894, 1942.9417117486498, 1989.5523507210762, 8903.0, 10236.48817559119, 12427.813582796265, 12778.10553261272, 13002.804957925639, 1735.3926125855849, 1740.5474576610172, 1770.6547223291464, 1806.2504060814747, 1826.3333883132561, 55797.44202557963, 56249.15626265609, 56775.432245677424, 56938.430615693724, 57277.427225727624, 9493.857592135986, 9691.07934746198, 9769.16962058233, 9834.0, 9916.355436896578, 11628.592999244986, 11646.76706465866, 11690.0, 11728.589499367481, 11750.0, 6792.42264407521, 6905.827354316082, 6969.721211151598, 7071.92928070723, 7131.0, 6396.680165991682, 6437.581557198767, 6477.4170324671, 6484.805455836333, 6516.0, 3925.391564307537, 3978.4827972363987, 4186.958130418657, 4203.327467605169, 4227.217964676544, 1667.84989350959, 1673.4644913627521, 1690.3407671008317, 1726.0765490462793, 1743.4595275464646, 363.1502284653923, 370.66640023978636, 372.8471326756071, 890.5547226386807, 903.3676426501476, 9524.285678574135, 9635.518224088768, 9686.128248457673, 9787.070228328297, 9840.803183936281, 376.8002958432035, 382.52757844062563, 382.8162482008651, 384.53279265692316, 395.1326837591459, 3867.971900029362, 5264.6838290427395, 5316.043112239757, 5363.597730170253, 5391.676499410048, 493783.0, 495381.0, 497579.0, 506818.0, 507515.0, 70468.64765676242, 71306.57386852338, 72501.63749181326, 74470.62764686142, 76798.6160069196, 1031.8400647899587, 1062.516554967488, 1062.7608788022633, 1063.3460421840666, 1073.6564299424265, 14810.25948702539, 14855.108693478425, 14949.476768313058, 14967.550973470814, 15230.010049346756, 32478.83760581182, 33203.667963320055, 33320.33359332848, 34166.316673666886, 34592.0, 42727.57272427236, 43439.78280108579, 44883.326750098124, 45024.54975450203, 45268.77365613151, 8005.75982720496, 8330.166983301622, 8341.916580834357, 8387.95806020966, 8475.74572762818, 15766.0, 15906.68186636284, 16008.0, 16177.59556011109, 17035.659286814443, 13926.094803837717, 14034.929825350808, 14134.15195088298, 14405.92797036008, 14411.711765764836, 12262.570810021607, 13378.0, 13742.312884355542, 13969.371378287799, 14392.42430302818, 14464.783028254795, 14600.561983140522, 14721.33753981052, 14777.926110369379, 14935.17856517902, 8375.41372103947, 8394.832103358021, 8407.327413806759, 8432.53621050848, 8440.957795210985, 10925.672229833117, 14119.058329584563, 14135.293235338399, 14155.64610884736, 14221.928890355483], "unit": "ms", "name": "jquery.html", "value": 7606.6982096795755}, {"lowerIsBetter": false, "replicates": [1447.2691290898094, 1634.664893696792, 1679.1855949864314, 1702.344597330028, 1706.1042952449961, 6333.5883167594075, 6435.742570297194, 6907.343802338783, 7268.600226987513, 7324.08448943882, 6947.201071876736, 7177.35403813658, 7234.819129521765, 7246.7825965221, 7290.979262903198, 2084.3225951565764, 2090.3833369156137, 2127.7233959585233, 2128.9148434062695, 2129.637961546533, 2080.9687854682193, 2092.5187206942414, 2095.1200495791804, 2115.947101322464, 2126.479012641905, 2061.556765295461, 2073.3365323096614, 2087.290321290761, 2090.508730448351, 2091.989540052298, 2065.5662310914727, 2085.9374218773387, 2088.3421722157473, 2088.937331880046, 2091.4144039668995, 2056.085042156241, 2086.95826083479, 2088.6136064828056, 2093.7801530839197, 2099.580083983194, 7051.400630946376, 7147.606881621508, 7162.820929476805, 7163.3552980232025, 7176.210616832144, 4070.959290407088, 4117.300058989979, 4147.6267135957605, 4160.521540022875, 4169.478815148106, 2319.176692274252, 2380.1074597026113, 2686.435848471823, 2699.3656490724666, 2700.1089640418613, 836.3225787112458, 873.8995015573227, 893.4326702543931, 904.068809126594, 911.7447114807865, 9468.005859384803, 9554.713358599252, 9579.042095790364, 9586.90413095867, 9598.66404675833, 3840.9231815363537, 3931.488906442144, 3932.2135572885536, 3952.26883026641, 3965.603439656069, 8383.329333653415, 8395.95802020986, 8405.201505856934, 8419.873701894476, 8422.0, 4225.936610950838, 4247.97876010618, 4250.4899412070135, 4260.0, 4266.274733295285, 3803.676687481595, 3840.731148819612, 3868.419737039467, 3869.903252418712, 3871.3999330103316, 3335.7998520088872, 3384.4077286474767, 3392.2367467319655, 3426.8971930842113, 3436.7937923724658, 1089.629525961161, 1105.1545567640762, 1106.607154460155, 1110.4947249001684, 1120.557379834977, 1122.9831552526718, 1184.7571247894161, 1197.7424853656332, 1200.8138738495547, 1224.240970598217, 6825.1127353443735, 6840.281770414134, 6932.272111428329, 6938.965305173442, 6939.583624982517, 400.87572852415263, 408.85281298732434, 412.7894773665452, 413.5988091551251, 415.00399042298125, 5320.733963301896, 5344.545713614386, 5360.946390536123, 5423.864403389947, 5424.972875135599, 7580.204078571671, 7778.338841198448, 8412.8317433651, 8560.315174786003, 8569.442986205877, 8338.332933365316, 8342.249197572248, 8378.790530236793, 8389.832203355898, 8457.112003239694, 6531.477481801445, 6545.378189071936, 6558.737650493927, 6682.164729408824, 6791.898121528181, 6380.680965951591, 6411.935880641134, 6421.903671444838, 6429.871402571829, 6437.0666253392055, 7417.294022374992, 7420.295071968154, 7582.696692132474, 7631.809204769926, 7638.274363935418, 7717.884231736416, 7813.843723125619, 7911.683532658629, 7928.682852685828, 7995.320397766255, 6318.905216421849, 6336.936630633634, 6352.396522330371, 6368.331325210971, 6431.871362572816, 6650.866982660416, 6691.0, 6726.529142960141, 6741.325867413219, 6752.898706519504, 6363.96818015907, 6401.0, 6449.193850768654, 6510.153680021567, 6548.377904099103, 6425.389587989133, 6434.935650643621, 6473.093766872736, 6495.1556297681, 6512.381323774234, 6553.836154096186, 6616.933830661632, 6619.702113404812, 6624.90062649051, 6641.867162656817, 5936.436038576328, 6037.728302226323, 6050.45545900871, 6062.545309101747, 6078.027515597483, 6021.2473440819895, 6046.09308603713, 6115.877682446415, 6120.663363515049, 6157.53818463626], "unit": "ms", "name": "mootools.html", "value": 4020.1678900659417}, {"lowerIsBetter": false, "replicates": [298.37490457491555, 302.2986670923457, 306.8818504875623, 309.6098915366637, 310.5062949909643, 5441.401445840955, 5469.124940009599, 5548.223248745169, 5575.804846830361, 5638.238837756901, 5369.328833895763, 5542.612017158801, 5551.944480555193, 5555.583331250152, 5579.7489112989915, 4272.594103560157, 4280.0, 4284.550122237167, 4293.549177336382, 4294.570542945712, 4287.056847493562, 4293.785310734466, 4299.269124248885, 4303.462067241595, 4304.784760761965, 4057.2088442753675, 4203.894902627429, 4262.573742625744, 4265.53079161292, 4268.253055715253, 4193.1404062167185, 4194.496660400741, 4194.643455306303, 4197.454330936989, 4219.156168766243, 3663.7984910829896, 3671.9816400917825, 3673.6326367363317, 3676.8345424455697, 3681.8159092045557, 5230.686158830483, 5235.476452354772, 5236.764345604457, 5267.3679158500845, 5291.788328466857, 4789.449213340476, 4790.065937142259, 4825.686330388514, 4834.468208497063, 4843.07981483517, 5633.267675202238, 5839.532837373, 5840.941590584082, 5845.327787304472, 5857.648541087548, 3972.880813575597, 3973.304671682444, 3974.1455587048636, 3978.3435733104, 3980.4029395590605, 6097.603655762361, 6127.172831667713, 6145.078238264251, 6155.58421563043, 6171.413715697002, 3923.372260438316, 4104.835806567764, 4116.238495878212, 4121.876343709693, 4130.380442933524, 4064.8577299794365, 4078.938815917764, 4080.81636326366, 4098.4467096941535, 4104.0, 4706.247000479907, 4711.222648263067, 4714.528547145258, 4730.101280756645, 4734.07685501324, 5734.627249228787, 5805.88388232233, 5809.0, 5809.2738407699035, 5809.854753631109, 1435.7415665180367, 1438.8057612222217, 1460.8466111058399, 1469.7868809022846, 1475.859793319633, 962.6486332488591, 986.1814693804125, 987.3039507147444, 1002.1682003936716, 1002.5087707023506, 5000.349954505891, 5001.174806157016, 5004.924926126111, 5044.243363495431, 5059.418166910778, 5988.970055149784, 5998.25021872266, 6003.519718422515, 6011.3086994995265, 6017.187679663277, 5023.472535383805, 5045.2432135180015, 5049.899002019939, 5060.1903695408555, 5068.41713202979, 3198.3123628420003, 3237.2877966847254, 3269.3134441767497, 3271.5910511186103, 3308.106811160973, 5776.797812076557, 5790.594658373958, 5826.650400975955, 5830.504407125357, 5831.941680583224, 6273.18448601688, 6312.179416675803, 6322.051692246107, 6331.810045698637, 6344.49244060474, 5670.347909990239, 5697.800576979868, 5767.394423585547, 5786.566007549451, 5824.650520968671, 6106.9083963739695, 6108.35862234459, 6118.418750218722, 6126.20359353299, 6148.354422785722, 5975.940240597713, 5990.251218597676, 5990.371011043778, 5996.760129594767, 5997.760089596542, 5811.418858114154, 5816.127580862904, 5824.883502330014, 5825.242718446575, 5826.41735826414, 3978.741381810173, 4052.0, 4092.0, 4093.058596522757, 4093.918121637491, 5936.614120082181, 6075.7569697213385, 6102.4507794298725, 6113.5414843886, 6122.602030867979, 5787.884242315215, 5839.795607153729, 5850.94149058521, 5902.61632993854, 5911.172435859069, 5835.708214589169, 5870.53035757147, 5881.264841894763, 5886.764529418775, 5889.793857214977, 5643.858903527444, 5736.770529178786, 5742.109972954198, 5744.425557444222, 5750.568707346882, 5822.505087067478, 5866.882662346644, 5921.289445266596, 5929.407059294036, 5936.614120082181, 5682.06245969427, 5685.71571421419, 5726.885462290814, 5738.368779434342, 5741.282339707536], "unit": "ms", "name": "prototype.html", "value": 4349.343553111343}, {"lowerIsBetter": false, "replicates": [730.2624349407097, 769.3921801776597, 797.6370751308156, 803.2128514056228, 808.490650889939, 10849.945750271247, 10977.451127443635, 11171.05046071084, 11175.329480231172, 11203.83194252086, 11812.940935295333, 11883.287002779818, 11903.7619247615, 11915.582954596592, 11966.940165299184, 792.8572856885759, 797.7925739307778, 813.5118928642826, 814.1288820961573, 815.2418251026543, 807.8061265296345, 807.8424707182102, 822.9506229626212, 825.5170725125779, 826.3348004856089, 837.0917554453395, 845.1379592815325, 847.720252316734, 851.6550796927254, 853.2917678327004, 840.995795021024, 844.2359664503634, 847.3306088190322, 848.1730312944891, 851.6848765956573, 621.5059028072693, 622.393166662505, 628.4972022382076, 630.3255516597243, 632.6141053957128, 11962.1626486146, 11980.400979950968, 12017.879821201763, 12057.819132713017, 12101.818472722829, 11323.0, 11721.648350549498, 11754.118441116865, 11823.704407389798, 12000.339981301026, 9744.366616169926, 9809.460479673615, 9853.0, 9909.108180263738, 10078.546465409074, 3265.755068369882, 3278.96721032789, 3298.191942973987, 3336.2660214752714, 3381.2730262993327, 36052.278954421025, 36066.63933360659, 36281.45577816335, 36807.07982300464, 36921.81539092314, 9050.456972581535, 9126.771830704152, 9169.816603667889, 9180.954095229481, 9181.265498760084, 15408.22958852053, 15663.216839157996, 15717.921410392875, 15730.370785168694, 15761.133137677538, 6431.324710905287, 6480.060391243243, 6577.572457790228, 6601.174853143357, 6612.338766123446, 3603.3153700796765, 3603.4054381027363, 3635.9091022724115, 3654.214343916071, 3670.339338918967, 2788.804783665124, 2792.1623512946035, 2803.2010876899985, 2803.3972695870484, 2815.81697189682, 497.6118627470579, 509.72474863573996, 513.6276199755222, 517.6919732759002, 520.5185203686575, 538.6310377391421, 592.4016743089511, 592.5970340168726, 604.3865476541314, 644.0725355488082, 7711.190325015793, 7737.729179478692, 7784.377249820114, 7914.802129946797, 8008.079070906921, 504.87630530520255, 560.7224423910191, 624.35691238024, 624.887520246351, 643.2120652201016, 3640.1445660269815, 3690.612485689018, 3782.0733920189728, 3829.4447305141157, 3895.2599006188734, 47393.0, 47491.0, 48104.0, 48131.27803082956, 48244.27633585499, 43253.0, 43427.13145737068, 44503.33245001327, 44561.77719111449, 44721.55278447239, 39396.212075758325, 39800.0, 40079.39880901789, 40164.59835401609, 40299.0, 7849.007226479411, 7856.764297071097, 8230.259276664889, 8253.711120110767, 8288.783313331198, 31132.22169445782, 31175.37649246957, 31221.219469512536, 31743.74035541802, 32316.0, 36376.81811590925, 36545.45181822222, 38614.4207836877, 40579.1884162321, 40757.38863916984, 9299.0, 10096.444695541815, 10159.695209143738, 10266.743331416475, 10382.3251488653, 11286.322820630789, 11491.310521368745, 11736.941315293368, 12065.577704780291, 12068.879311206776, 10856.363861692898, 11111.944440277746, 11176.497057632263, 11188.83216751733, 11216.775664486828, 9999.250056245955, 10241.0, 10345.224108192066, 10581.841272381074, 11110.277831940897, 10231.13035392, 10286.125679317043, 10364.481775911023, 10649.094826939487, 11292.378919159524, 9040.215701949895, 9337.906620933976, 9399.34204605671, 9575.09036641518, 9653.324267301221, 8913.0, 9197.586108625263, 9455.952720236355, 9527.523623818643, 9633.277504187354], "unit": "ms", "name": "yui.html", "value": 5784.557147782026}], "name": "dromaeo_css", "value": 6251.759938478406}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 108.0, 110.0, 112.0, 111.0, 125.0, 110.0, 112.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [160.0, 130.0, 153.0, 159.0, 137.0, 167.0, 165.0, 130.0, 172.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 164.0, 161.0, 165.0, 163.0, 164.0, 164.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 73.0, 72.0, 74.0, 87.0, 139.0, 72.0, 71.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 130.0, 93.0, 94.0, 93.0, 134.0, 93.0, 94.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 150.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [96.0, 100.0, 97.0, 96.0, 96.0, 96.0, 96.0, 102.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 73.0, 76.0, 74.0, 73.0, 72.0, 75.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.1}, {"lowerIsBetter": true, "replicates": [68.0, 76.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 83.0, 84.0, 85.0, 96.0, 85.0, 84.0, 87.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [126.0, 126.0, 130.0, 131.0, 131.0, 134.0, 120.0, 124.0, 122.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [135.0, 164.0, 136.0, 148.0, 151.0, 147.0, 146.0, 147.0, 139.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 75.0, 76.0, 68.0, 68.0, 69.0, 71.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1537.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [184.0264998159735], "unit": "score", "name": "DeltaBlue", "value": 359.285212}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1061.5058324496288], "unit": "score", "name": "RayTrace", "value": 697.1125144855143}, {"lowerIsBetter": false, "replicates": [702.2471910112359], "unit": "score", "name": "Earley", "value": 949.0433120000004}, {"lowerIsBetter": false, "replicates": [12096.385542168675], "unit": "score", "name": "Boyer", "value": 55.096044820717125}, {"lowerIsBetter": false, "replicates": [25871.79487179487], "unit": "score", "name": "RegExp", "value": 35.21151139742318}, {"lowerIsBetter": false, "replicates": [652.2301228183582], "unit": "score", "name": "Splay", "value": 124.94209811694745}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21302.24180280016}]} 13:28:33 INFO - RETURN: dromaeo_css: 6251.76 13:28:33 INFO - RETURN: kraken: 1537.50 13:28:33 INFO - RETURN: v8_7: 21302.24 13:28:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21302.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1537.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6251.76"}}} 13:28:33 INFO - Return code: 0 13:28:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:28:33 INFO - # TBPL SUCCESS # 13:28:33 INFO - Running post-action listener: _resource_record_post_action 13:28:33 INFO - Running post-run listener: _resource_record_post_run 13:28:34 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 10280960; Write bytes: 410624000; Read time: 3136; Write time: 360344 13:28:34 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 11907072; Read time: 0; Write time: 31016 13:28:34 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8519680; Write bytes: 398716928; Read time: 3096; Write time: 329328 13:28:34 INFO - Running post-run listener: _upload_blobber_files 13:28:34 INFO - Blob upload gear active. 13:28:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:28:34 INFO - Copying logs to upload dir... 13:28:34 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.945045 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-04 13:28:34.756285) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 13:28:34.759415) ========= 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=01deea79d00cc2c334834894000001d2-1449263235.113693-890591493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009955 build_url: 'https://queue.taskcluster.net/v1/task/sVKyaDWXQk2P3TgjcvC9_g/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-04 13:28:34.810459) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:28:34.810811) ========= 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=01deea79d00cc2c334834894000001d2-1449263235.113693-890591493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004429 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 13:28:34.860836) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 13:28:34.861158) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 13:28:34.861465) ========= ========= Total master_lag: 0.55 =========