builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1449614300.68 results: success (0) buildid: 20151208131840 builduid: d2c333fbc0254ecd9c12a31b5ceb2430 revision: a8965ae93c5d098a4f91ad9da72150bb43df07a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.682295) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.682781) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.683113) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006364 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.710716) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.711512) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.726385) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.727014) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004608 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.788231) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.788966) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:20.789850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2015-12-08 14:38:20.790624) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-08 14:38:22-- 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% 69.1M=0s 2015-12-08 14:38:22 (69.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107412 ========= master_lag: 5.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2015-12-08 14:38:26.094724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:26.095529) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019995 ========= master_lag: 0.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:26.379925) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 14:38:26.380315) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8965ae93c5d098a4f91ad9da72150bb43df07a7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a8965ae93c5d098a4f91ad9da72150bb43df07a7 --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=5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-08 14:38:27,689 truncating revision to first 12 chars 2015-12-08 14:38:27,689 Setting DEBUG logging. 2015-12-08 14:38:27,689 attempt 1/10 2015-12-08 14:38:27,689 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8965ae93c5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-08 14:38:28,678 unpacking tar archive at: mozilla-central-a8965ae93c5d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.276697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 14:38:27.680401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:27.681170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:27.692342) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:27.692648) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 14:38:27.693112) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-08 14:38:27.693471) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:38:29 INFO - MultiFileLogger online at 20151208 14:38:29 in /builds/slave/test 14:38:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:38:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:38:29 INFO - {'append_to_log': False, 14:38:29 INFO - 'base_work_dir': '/builds/slave/test', 14:38:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:38:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:38:29 INFO - 'branch': 'Firefox-Non-PGO', 14:38:29 INFO - 'buildbot_json_path': 'buildprops.json', 14:38:29 INFO - 'config_files': ('talos/linux_config.py',), 14:38:29 INFO - 'default_actions': ('clobber', 14:38:29 INFO - 'read-buildbot-config', 14:38:29 INFO - 'download-and-extract', 14:38:29 INFO - 'populate-webroot', 14:38:29 INFO - 'create-virtualenv', 14:38:29 INFO - 'install', 14:38:29 INFO - 'run-tests'), 14:38:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:38:29 INFO - 'download_minidump_stackwalk': True, 14:38:29 INFO - 'download_symbols': 'ondemand', 14:38:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:38:29 INFO - 'tooltool.py': '/tools/tooltool.py', 14:38:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:38:29 INFO - '/tools/misc-python/virtualenv.py')}, 14:38:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:38:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:38:29 INFO - 'installer_path': 'installer.exe', 14:38:29 INFO - 'log_level': 'info', 14:38:29 INFO - 'log_name': 'talos', 14:38:29 INFO - 'log_to_console': True, 14:38:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:38:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:38:29 INFO - 'opt_config_files': (), 14:38:29 INFO - 'pip_index': False, 14:38:29 INFO - 'sps_profile': False, 14:38:29 INFO - 'sps_profile_interval': 0, 14:38:29 INFO - 'suite': 'dromaeojs-e10s', 14:38:29 INFO - 'system_bits': '64', 14:38:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:38:29 INFO - 'title': 'talos-linux64-ix-024', 14:38:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:38:29 INFO - 'use_talos_json': True, 14:38:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:38:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:38:29 INFO - 'work_dir': 'build'} 14:38:29 INFO - ##### 14:38:29 INFO - ##### Running clobber step. 14:38:29 INFO - ##### 14:38:29 INFO - Running pre-action listener: _resource_record_pre_action 14:38:29 INFO - Running main action method: clobber 14:38:29 INFO - rmtree: /builds/slave/test/build 14:38:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:38:29 INFO - Running post-action listener: _resource_record_post_action 14:38:29 INFO - ##### 14:38:29 INFO - ##### Running read-buildbot-config step. 14:38:29 INFO - ##### 14:38:29 INFO - Running pre-action listener: _resource_record_pre_action 14:38:29 INFO - Running main action method: read_buildbot_config 14:38:29 INFO - Using buildbot properties: 14:38:29 INFO - { 14:38:29 INFO - "properties": { 14:38:29 INFO - "buildnumber": 140, 14:38:29 INFO - "product": "firefox", 14:38:29 INFO - "script_repo_revision": "production", 14:38:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 14:38:29 INFO - "repository": "", 14:38:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 14:38:29 INFO - "buildid": "20151208131840", 14:38:29 INFO - "slavename": "talos-linux64-ix-024", 14:38:29 INFO - "pgo_build": "False", 14:38:29 INFO - "basedir": "/builds/slave/test", 14:38:29 INFO - "project": "", 14:38:29 INFO - "platform": "ubuntu64_hw", 14:38:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:38:29 INFO - "slavebuilddir": "test", 14:38:29 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:38:29 INFO - "branch": "mozilla-central", 14:38:29 INFO - "repo_path": "mozilla-central", 14:38:29 INFO - "stage_platform": "linux64", 14:38:29 INFO - "builduid": "d2c333fbc0254ecd9c12a31b5ceb2430", 14:38:29 INFO - "revision": "a8965ae93c5d098a4f91ad9da72150bb43df07a7" 14:38:29 INFO - }, 14:38:29 INFO - "sourcestamp": { 14:38:29 INFO - "repository": "", 14:38:29 INFO - "hasPatch": false, 14:38:29 INFO - "project": "", 14:38:29 INFO - "branch": "mozilla-central-linux64-talos", 14:38:29 INFO - "changes": [ 14:38:29 INFO - { 14:38:29 INFO - "category": null, 14:38:29 INFO - "files": [ 14:38:29 INFO - { 14:38:29 INFO - "url": null, 14:38:29 INFO - "name": "https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:38:29 INFO - } 14:38:29 INFO - ], 14:38:29 INFO - "repository": "", 14:38:29 INFO - "rev": "a8965ae93c5d098a4f91ad9da72150bb43df07a7", 14:38:29 INFO - "who": "nthomas@mozilla.com", 14:38:29 INFO - "when": 1449614172, 14:38:29 INFO - "number": 7091856, 14:38:29 INFO - "comments": "Bug 1079858, Deal with deprecation of SHA1 (SHA-1) Authenticode signatures for Windows signing, part 2 (swap cert), r=catlee, a=lizzard", 14:38:29 INFO - "project": "", 14:38:29 INFO - "at": "Tue 08 Dec 2015 14:36:12", 14:38:29 INFO - "branch": "mozilla-central-linux64-talos", 14:38:29 INFO - "revlink": "", 14:38:29 INFO - "properties": [ 14:38:29 INFO - [ 14:38:29 INFO - "buildid", 14:38:29 INFO - "20151208131840", 14:38:29 INFO - "Change" 14:38:29 INFO - ], 14:38:29 INFO - [ 14:38:29 INFO - "builduid", 14:38:29 INFO - "d2c333fbc0254ecd9c12a31b5ceb2430", 14:38:29 INFO - "Change" 14:38:29 INFO - ], 14:38:29 INFO - [ 14:38:29 INFO - "pgo_build", 14:38:29 INFO - "False", 14:38:29 INFO - "Change" 14:38:29 INFO - ] 14:38:29 INFO - ], 14:38:29 INFO - "revision": "a8965ae93c5d098a4f91ad9da72150bb43df07a7" 14:38:29 INFO - } 14:38:29 INFO - ], 14:38:29 INFO - "revision": "a8965ae93c5d098a4f91ad9da72150bb43df07a7" 14:38:29 INFO - } 14:38:29 INFO - } 14:38:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:38:29 INFO - Running post-action listener: _resource_record_post_action 14:38:29 INFO - ##### 14:38:29 INFO - ##### Running download-and-extract step. 14:38:29 INFO - ##### 14:38:29 INFO - Running pre-action listener: _resource_record_pre_action 14:38:29 INFO - Running main action method: download_and_extract 14:38:29 INFO - mkdir: /builds/slave/test/build/tests 14:38:29 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')]} 14:38:29 INFO - https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:38:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/test_packages.json 14:38:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/test_packages.json 14:38:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:38:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:38:30 INFO - Downloaded 1302 bytes. 14:38:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:38:30 INFO - Using the following test package requirements: 14:38:30 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:38:30 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:38:30 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:30 INFO - u'jsshell-linux-x86_64.zip'], 14:38:30 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:38:30 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:38:30 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:38:30 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:38:30 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:38:30 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:38:30 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:30 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:38:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:38:30 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')]} 14:38:30 INFO - https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:38:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:38:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:38:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/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 14:38:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/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 14:38:31 INFO - Downloaded 21860094 bytes. 14:38:31 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 14:38:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:38:31 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 14:38:32 INFO - Return code: 0 14:38:32 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 14:38: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')]} 14:38:32 INFO - https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:38:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:38:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:38:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/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 14:38:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/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 14:38:34 INFO - Downloaded 21860094 bytes. 14:38:34 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 14:38:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:38:34 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 14:38:35 INFO - Return code: 0 14:38:35 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')]} 14:38:35 INFO - https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/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 14:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/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 14:38:36 INFO - Downloaded 11132038 bytes. 14:38:36 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 14:38:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:38:36 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 14:38:36 INFO - Return code: 0 14:38: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')]} 14:38:36 INFO - https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:38:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:38:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:38:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/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 14:38:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/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 14:38:38 INFO - Downloaded 57731777 bytes. 14:38:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:38:38 INFO - mkdir: /builds/slave/test/properties 14:38:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:38:38 INFO - Writing to file /builds/slave/test/properties/build_url 14:38:38 INFO - Contents: 14:38:38 INFO - build_url:https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:38:38 INFO - Running post-action listener: _resource_record_post_action 14:38:38 INFO - Running post-action listener: set_extra_try_arguments 14:38:38 INFO - ##### 14:38:38 INFO - ##### Running populate-webroot step. 14:38:38 INFO - ##### 14:38:38 INFO - Running pre-action listener: _resource_record_pre_action 14:38:38 INFO - Running main action method: populate_webroot 14:38:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:38:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:38:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:38:38 INFO - '--tppagecycles', 14:38:38 INFO - '7'], 14:38:38 INFO - 'tests': ['tsvgm']}}, 14:38:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:38:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:38:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:38:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:38:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:38:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:38:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:38:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:38 INFO - 'talos_options': ['--e10s'], 14:38:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:38:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:38 INFO - 'tests': ['damp', 'tps']}, 14:38:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:38 INFO - 'talos_options': ['--e10s'], 14:38:38 INFO - 'tests': ['damp', 'tps']}, 14:38:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:38:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:38:38 INFO - 'other': {'tests': ['a11yr', 14:38:38 INFO - 'ts_paint', 14:38:38 INFO - 'tpaint', 14:38:38 INFO - 'sessionrestore', 14:38:38 INFO - 'sessionrestore_no_auto_restore']}, 14:38:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:38:38 INFO - 'tests': ['a11yr', 14:38:38 INFO - 'ts_paint', 14:38:38 INFO - 'tpaint', 14:38:38 INFO - 'sessionrestore', 14:38:38 INFO - 'sessionrestore_no_auto_restore']}, 14:38:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:38:38 INFO - 'tests': ['a11yr', 14:38:38 INFO - 'ts_paint', 14:38:38 INFO - 'tpaint', 14:38:38 INFO - 'sessionrestore', 14:38:38 INFO - 'sessionrestore_no_auto_restore']}, 14:38:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:38:38 INFO - 'tests': ['a11yr', 14:38:38 INFO - 'ts_paint', 14:38:38 INFO - 'tpaint', 14:38:38 INFO - 'sessionrestore', 14:38:38 INFO - 'sessionrestore_no_auto_restore']}, 14:38:38 INFO - 'other_l64': {'tests': ['a11yr', 14:38:38 INFO - 'ts_paint', 14:38:38 INFO - 'tpaint', 14:38:38 INFO - 'sessionrestore', 14:38:38 INFO - 'sessionrestore_no_auto_restore']}, 14:38:38 INFO - 'other_nol64': {'tests': ['a11yr', 14:38:38 INFO - 'ts_paint', 14:38:38 INFO - 'tpaint', 14:38:38 INFO - 'sessionrestore', 14:38:38 INFO - 'sessionrestore_no_auto_restore']}, 14:38:38 INFO - 'svgr': {'tests': ['tsvgx', 14:38:38 INFO - 'tsvgr_opacity', 14:38:38 INFO - 'tart', 14:38:38 INFO - 'tscrollx', 14:38:38 INFO - 'cart']}, 14:38:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:38:38 INFO - 'tests': ['tsvgx', 14:38:38 INFO - 'tsvgr_opacity', 14:38:38 INFO - 'tart', 14:38:38 INFO - 'tscrollx', 14:38:38 INFO - 'cart']}, 14:38:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:38 INFO - 'tests': ['tp5o']}, 14:38:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:38 INFO - 'talos_options': ['--e10s'], 14:38:38 INFO - 'tests': ['tp5o']}, 14:38:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:38 INFO - 'talos_options': ['--xperf_path', 14:38:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:38:38 INFO - 'tests': ['tp5n']}, 14:38:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:38:38 INFO - 'talos_options': ['--e10s', 14:38:38 INFO - '--xperf_path', 14:38:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:38:38 INFO - 'tests': ['tp5n']}}, 14:38:38 INFO - 'talos.zip': {'path': '', 14:38:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:38:38 INFO - Running post-action listener: _resource_record_post_action 14:38:38 INFO - ##### 14:38:38 INFO - ##### Running create-virtualenv step. 14:38:38 INFO - ##### 14:38:38 INFO - Running pre-action listener: _resource_record_pre_action 14:38:38 INFO - Running main action method: create_virtualenv 14:38:38 INFO - Creating virtualenv /builds/slave/test/build/venv 14:38:38 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 14:38:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:38:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:38:38 INFO - Using real prefix '/usr' 14:38:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:38:39 INFO - Installing distribute.............................................................................................................................................................................................done. 14:38:41 INFO - Installing pip.................done. 14:38:41 INFO - Return code: 0 14:38:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:38: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')]} 14:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38: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')]} 14:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f3f068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2441240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', '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 14:38: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', 'pip>=1.5'] in /builds/slave/test/build 14:38: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 pip>=1.5 14:38:41 INFO - Using env: {'DISPLAY': ':0', 14:38:41 INFO - 'HOME': '/home/cltbld', 14:38:41 INFO - 'LANG': 'en_US.UTF-8', 14:38:41 INFO - 'LANGUAGE': 'en_US:en', 14:38:41 INFO - 'LOGNAME': 'cltbld', 14:38:41 INFO - 'MAIL': '/var/mail/cltbld', 14:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:41 INFO - 'MOZ_NO_REMOTE': '1', 14:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:41 INFO - 'NO_EM_RESTART': '1', 14:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:41 INFO - 'PWD': '/builds/slave/test', 14:38:41 INFO - 'SHELL': '/bin/bash', 14:38:41 INFO - 'SHLVL': '1', 14:38:41 INFO - 'TERM': 'linux', 14:38:41 INFO - 'TMOUT': '86400', 14:38:41 INFO - 'USER': 'cltbld', 14:38:41 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:41 INFO - '_': '/tools/buildbot/bin/python'} 14:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:41 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 14:38:41 INFO - Cleaning up... 14:38:41 INFO - Return code: 0 14:38:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:38: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')]} 14:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38: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')]} 14:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38: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', '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 0x7f7f3f068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2441240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', '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 14:38: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', 'psutil>=0.7.1'] in /builds/slave/test/build 14:38: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 psutil>=0.7.1 14:38:41 INFO - Using env: {'DISPLAY': ':0', 14:38:41 INFO - 'HOME': '/home/cltbld', 14:38:41 INFO - 'LANG': 'en_US.UTF-8', 14:38:41 INFO - 'LANGUAGE': 'en_US:en', 14:38:41 INFO - 'LOGNAME': 'cltbld', 14:38:41 INFO - 'MAIL': '/var/mail/cltbld', 14:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:41 INFO - 'MOZ_NO_REMOTE': '1', 14:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:41 INFO - 'NO_EM_RESTART': '1', 14:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:41 INFO - 'PWD': '/builds/slave/test', 14:38:41 INFO - 'SHELL': '/bin/bash', 14:38:41 INFO - 'SHLVL': '1', 14:38:41 INFO - 'TERM': 'linux', 14:38:41 INFO - 'TMOUT': '86400', 14:38:41 INFO - 'USER': 'cltbld', 14:38:41 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:41 INFO - '_': '/tools/buildbot/bin/python'} 14:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:41 INFO - Downloading/unpacking psutil>=0.7.1 14:38:41 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 14:38:41 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 14:38:41 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 14:38:41 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 14:38:41 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 14:38:41 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 14:38:43 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:38:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:38:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:38:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:38:43 INFO - Installing collected packages: psutil 14:38:43 INFO - Running setup.py install for psutil 14:38:43 INFO - building 'psutil._psutil_linux' extension 14:38:43 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 14:38:43 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 14:38:43 INFO - building 'psutil._psutil_posix' extension 14:38:43 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 14:38:43 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 14:38:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:38:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:38:43 INFO - Successfully installed psutil 14:38:43 INFO - Cleaning up... 14:38:43 INFO - Return code: 0 14:38:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:43 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 0x7f7f3f068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2441240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', '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 14:38:43 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 14:38:43 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 14:38:43 INFO - Using env: {'DISPLAY': ':0', 14:38:43 INFO - 'HOME': '/home/cltbld', 14:38:43 INFO - 'LANG': 'en_US.UTF-8', 14:38:43 INFO - 'LANGUAGE': 'en_US:en', 14:38:43 INFO - 'LOGNAME': 'cltbld', 14:38:43 INFO - 'MAIL': '/var/mail/cltbld', 14:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:43 INFO - 'MOZ_NO_REMOTE': '1', 14:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:43 INFO - 'NO_EM_RESTART': '1', 14:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:43 INFO - 'PWD': '/builds/slave/test', 14:38:43 INFO - 'SHELL': '/bin/bash', 14:38:43 INFO - 'SHLVL': '1', 14:38:43 INFO - 'TERM': 'linux', 14:38:43 INFO - 'TMOUT': '86400', 14:38:43 INFO - 'USER': 'cltbld', 14:38:43 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:43 INFO - '_': '/tools/buildbot/bin/python'} 14:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:38: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 14:38: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 14:38: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 14:38: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 14:38: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 14:38: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 14:38:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:38:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:38:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:38:45 INFO - Installing collected packages: mozsystemmonitor 14:38:45 INFO - Running setup.py install for mozsystemmonitor 14:38:45 INFO - Successfully installed mozsystemmonitor 14:38:45 INFO - Cleaning up... 14:38:45 INFO - Return code: 0 14:38:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:38: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')]} 14:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38: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')]} 14:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:45 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 0x7f7f3f068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2441240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', '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 14:38:45 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 14:38:45 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 14:38:45 INFO - Using env: {'DISPLAY': ':0', 14:38:45 INFO - 'HOME': '/home/cltbld', 14:38:45 INFO - 'LANG': 'en_US.UTF-8', 14:38:45 INFO - 'LANGUAGE': 'en_US:en', 14:38:45 INFO - 'LOGNAME': 'cltbld', 14:38:45 INFO - 'MAIL': '/var/mail/cltbld', 14:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:45 INFO - 'MOZ_NO_REMOTE': '1', 14:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:45 INFO - 'NO_EM_RESTART': '1', 14:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:45 INFO - 'PWD': '/builds/slave/test', 14:38:45 INFO - 'SHELL': '/bin/bash', 14:38:45 INFO - 'SHLVL': '1', 14:38:45 INFO - 'TERM': 'linux', 14:38:45 INFO - 'TMOUT': '86400', 14:38:45 INFO - 'USER': 'cltbld', 14:38:45 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:45 INFO - '_': '/tools/buildbot/bin/python'} 14:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:46 INFO - Downloading/unpacking blobuploader==1.2.4 14:38:46 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 14:38:46 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 14:38:46 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 14:38:46 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 14:38:46 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 14:38:46 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 14:38:47 INFO - Downloading blobuploader-1.2.4.tar.gz 14:38:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:38:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:38:47 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 14:38:47 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 14:38:47 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 14:38:47 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 14:38:47 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 14:38:47 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 14:38:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:38:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:48 INFO - Downloading docopt-0.6.1.tar.gz 14:38:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:38:48 INFO - Installing collected packages: blobuploader, requests, docopt 14:38:48 INFO - Running setup.py install for blobuploader 14:38:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:38:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:38:48 INFO - Running setup.py install for requests 14:38:48 INFO - Running setup.py install for docopt 14:38:49 INFO - Successfully installed blobuploader requests docopt 14:38:49 INFO - Cleaning up... 14:38:49 INFO - Return code: 0 14:38:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:49 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 0x7f7f3f068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2441240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', '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 14:38:49 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 14:38:49 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 14:38:49 INFO - Using env: {'DISPLAY': ':0', 14:38:49 INFO - 'HOME': '/home/cltbld', 14:38:49 INFO - 'LANG': 'en_US.UTF-8', 14:38:49 INFO - 'LANGUAGE': 'en_US:en', 14:38:49 INFO - 'LOGNAME': 'cltbld', 14:38:49 INFO - 'MAIL': '/var/mail/cltbld', 14:38:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:49 INFO - 'MOZ_NO_REMOTE': '1', 14:38:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:49 INFO - 'NO_EM_RESTART': '1', 14:38:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:49 INFO - 'PWD': '/builds/slave/test', 14:38:49 INFO - 'SHELL': '/bin/bash', 14:38:49 INFO - 'SHLVL': '1', 14:38:49 INFO - 'TERM': 'linux', 14:38:49 INFO - 'TMOUT': '86400', 14:38:49 INFO - 'USER': 'cltbld', 14:38:49 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:38:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:49 INFO - '_': '/tools/buildbot/bin/python'} 14:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:38:49 INFO - Running setup.py (path:/tmp/pip-6iCshQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:38:49 INFO - Running setup.py (path:/tmp/pip-iaPPum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:38:49 INFO - Running setup.py (path:/tmp/pip-7JxjkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:38:49 INFO - Running setup.py (path:/tmp/pip-YpwOk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:38:49 INFO - Running setup.py (path:/tmp/pip-D3cfTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:38:49 INFO - Running setup.py (path:/tmp/pip-sFHUoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:38:49 INFO - Running setup.py (path:/tmp/pip-Mqlxbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:38:49 INFO - Running setup.py (path:/tmp/pip-syky_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:38:49 INFO - Running setup.py (path:/tmp/pip-_p2h1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:38:49 INFO - Running setup.py (path:/tmp/pip-N4hBiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:38:50 INFO - Running setup.py (path:/tmp/pip-w7FGhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:38:50 INFO - Running setup.py (path:/tmp/pip-wOWJVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:38:50 INFO - Running setup.py (path:/tmp/pip-JNVSz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:38:50 INFO - Running setup.py (path:/tmp/pip-hPvykV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:50 INFO - Running setup.py (path:/tmp/pip-_CPKSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:38:50 INFO - Running setup.py (path:/tmp/pip-ZV9fxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:38:50 INFO - Running setup.py (path:/tmp/pip-mxoZ0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:38:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:38:50 INFO - Running setup.py install for manifestparser 14:38:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:38:50 INFO - Running setup.py install for mozcrash 14:38:50 INFO - Running setup.py install for mozdebug 14:38:50 INFO - Running setup.py install for mozdevice 14:38:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:38:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:38:50 INFO - Running setup.py install for mozfile 14:38:51 INFO - Running setup.py install for mozhttpd 14:38:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Running setup.py install for mozinfo 14:38:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Running setup.py install for mozInstall 14:38:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Running setup.py install for mozleak 14:38:51 INFO - Running setup.py install for mozlog 14:38:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Running setup.py install for moznetwork 14:38:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Running setup.py install for mozprocess 14:38:51 INFO - Running setup.py install for mozprofile 14:38:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:38:51 INFO - Running setup.py install for mozrunner 14:38:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:38:52 INFO - Running setup.py install for mozscreenshot 14:38:52 INFO - Running setup.py install for moztest 14:38:52 INFO - Running setup.py install for mozversion 14:38:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:38:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:38:52 INFO - Cleaning up... 14:38:52 INFO - Return code: 0 14:38:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38: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')]} 14:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38: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')]} 14:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38: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', '-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 0x7f7f3f068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2441240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', '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 14:38:52 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 14:38:52 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 14:38:52 INFO - Using env: {'DISPLAY': ':0', 14:38:52 INFO - 'HOME': '/home/cltbld', 14:38:52 INFO - 'LANG': 'en_US.UTF-8', 14:38:52 INFO - 'LANGUAGE': 'en_US:en', 14:38:52 INFO - 'LOGNAME': 'cltbld', 14:38:52 INFO - 'MAIL': '/var/mail/cltbld', 14:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:52 INFO - 'MOZ_NO_REMOTE': '1', 14:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:52 INFO - 'NO_EM_RESTART': '1', 14:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:52 INFO - 'PWD': '/builds/slave/test', 14:38:52 INFO - 'SHELL': '/bin/bash', 14:38:52 INFO - 'SHLVL': '1', 14:38:52 INFO - 'TERM': 'linux', 14:38:52 INFO - 'TMOUT': '86400', 14:38:52 INFO - 'USER': 'cltbld', 14:38:52 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:52 INFO - '_': '/tools/buildbot/bin/python'} 14:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:38:52 INFO - Running setup.py (path:/tmp/pip-_XetI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:38:52 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)) 14:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:38:52 INFO - Running setup.py (path:/tmp/pip-EPiuAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:38:52 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)) 14:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:38:52 INFO - Running setup.py (path:/tmp/pip-DoY0tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:38:52 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)) 14:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:38:52 INFO - Running setup.py (path:/tmp/pip-42kyMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:38:52 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)) 14:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:38:52 INFO - Running setup.py (path:/tmp/pip-60fLec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:38:52 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)) 14:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:38:52 INFO - Running setup.py (path:/tmp/pip-RzA3Mu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:38:52 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)) 14:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:38:52 INFO - Running setup.py (path:/tmp/pip-eX2hY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:38:53 INFO - Running setup.py (path:/tmp/pip-TOxqBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:38:53 INFO - Running setup.py (path:/tmp/pip-v99vPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:38:53 INFO - Running setup.py (path:/tmp/pip-ANAkfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:38:53 INFO - Running setup.py (path:/tmp/pip-WJo6Ez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:38:53 INFO - Running setup.py (path:/tmp/pip-yhi8e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:38:53 INFO - Running setup.py (path:/tmp/pip-Ye5ARM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:38:53 INFO - Running setup.py (path:/tmp/pip-hZuY4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:53 INFO - Running setup.py (path:/tmp/pip-0ploB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:38:53 INFO - Running setup.py (path:/tmp/pip-ca27Kq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:38:53 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)) 14:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:38:53 INFO - Running setup.py (path:/tmp/pip-7SGuZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:38:53 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)) 14:38:53 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)) 14:38:53 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)) 14:38:53 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)) 14:38:53 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)) 14:38:53 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)) 14:38:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:55 INFO - Downloading blessings-1.5.1.tar.gz 14:38:55 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 14:38:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:38:55 INFO - Installing collected packages: blessings 14:38:55 INFO - Running setup.py install for blessings 14:38:55 INFO - Successfully installed blessings 14:38:55 INFO - Cleaning up... 14:38:55 INFO - Return code: 0 14:38:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:38:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:38:55 INFO - Reading from file tmpfile_stdout 14:38:55 INFO - Current package versions: 14:38:55 INFO - argparse == 1.2.1 14:38:55 INFO - blessings == 1.5.1 14:38:55 INFO - blobuploader == 1.2.4 14:38:55 INFO - docopt == 0.6.1 14:38:55 INFO - manifestparser == 1.1 14:38:55 INFO - mozInstall == 1.12 14:38:55 INFO - mozcrash == 0.16 14:38:55 INFO - mozdebug == 0.1 14:38:55 INFO - mozdevice == 0.47 14:38:55 INFO - mozfile == 1.2 14:38:55 INFO - mozhttpd == 0.7 14:38:55 INFO - mozinfo == 0.9 14:38:55 INFO - mozleak == 0.1 14:38:55 INFO - mozlog == 3.1 14:38:55 INFO - moznetwork == 0.27 14:38:55 INFO - mozprocess == 0.22 14:38:55 INFO - mozprofile == 0.27 14:38:55 INFO - mozrunner == 6.11 14:38:55 INFO - mozscreenshot == 0.1 14:38:55 INFO - mozsystemmonitor == 0.0 14:38:55 INFO - moztest == 0.7 14:38:55 INFO - mozversion == 1.4 14:38:55 INFO - psutil == 3.1.1 14:38:55 INFO - requests == 1.2.3 14:38:55 INFO - wsgiref == 0.1.2 14:38:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:55 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 0x7f7f3f068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2441240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', '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 14:38:55 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 14:38:55 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 14:38:55 INFO - Using env: {'DISPLAY': ':0', 14:38:55 INFO - 'HOME': '/home/cltbld', 14:38:55 INFO - 'LANG': 'en_US.UTF-8', 14:38:55 INFO - 'LANGUAGE': 'en_US:en', 14:38:55 INFO - 'LOGNAME': 'cltbld', 14:38:55 INFO - 'MAIL': '/var/mail/cltbld', 14:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:55 INFO - 'MOZ_NO_REMOTE': '1', 14:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:55 INFO - 'NO_EM_RESTART': '1', 14:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:55 INFO - 'PWD': '/builds/slave/test', 14:38:55 INFO - 'SHELL': '/bin/bash', 14:38:55 INFO - 'SHLVL': '1', 14:38:55 INFO - 'TERM': 'linux', 14:38:55 INFO - 'TMOUT': '86400', 14:38:55 INFO - 'USER': 'cltbld', 14:38:55 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:55 INFO - '_': '/tools/buildbot/bin/python'} 14:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:56 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)) 14:38:56 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)) 14:38:56 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)) 14:38:56 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)) 14:38:56 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)) 14:38:56 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)) 14:38:56 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)) 14:38:56 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)) 14:38:56 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)) 14:38:56 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)) 14:38:56 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)) 14:38:56 INFO - Cleaning up... 14:38:56 INFO - Return code: 0 14:38:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:56 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 0x7f7f3f068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2441240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', '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 14:38:56 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 14:38:56 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 14:38:56 INFO - Using env: {'DISPLAY': ':0', 14:38:56 INFO - 'HOME': '/home/cltbld', 14:38:56 INFO - 'LANG': 'en_US.UTF-8', 14:38:56 INFO - 'LANGUAGE': 'en_US:en', 14:38:56 INFO - 'LOGNAME': 'cltbld', 14:38:56 INFO - 'MAIL': '/var/mail/cltbld', 14:38:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:56 INFO - 'MOZ_NO_REMOTE': '1', 14:38:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:56 INFO - 'NO_EM_RESTART': '1', 14:38:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:56 INFO - 'PWD': '/builds/slave/test', 14:38:56 INFO - 'SHELL': '/bin/bash', 14:38:56 INFO - 'SHLVL': '1', 14:38:56 INFO - 'TERM': 'linux', 14:38:56 INFO - 'TMOUT': '86400', 14:38:56 INFO - 'USER': 'cltbld', 14:38:56 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:38:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:56 INFO - '_': '/tools/buildbot/bin/python'} 14:38:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:56 INFO - Downloading/unpacking jsonschema 14:38: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 14:38: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 14:38: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 14:38: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 14:38: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 14:38: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 14:38:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:38:58 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 14:38:58 INFO - Downloading/unpacking functools32 (from jsonschema) 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 INFO - Downloading functools32-3.2.3-2.tar.gz 14:38:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:38:58 INFO - warning: no files found matching '*.txt' 14:38:58 INFO - no previously-included directories found matching 'build' 14:38:58 INFO - no previously-included directories found matching 'dist' 14:38:58 INFO - no previously-included directories found matching '.git*' 14:38:58 INFO - Installing collected packages: jsonschema, functools32 14:38:58 INFO - Running setup.py install for functools32 14:38:58 INFO - warning: no files found matching '*.txt' 14:38:58 INFO - no previously-included directories found matching 'build' 14:38:58 INFO - no previously-included directories found matching 'dist' 14:38:58 INFO - no previously-included directories found matching '.git*' 14:38:58 INFO - Successfully installed jsonschema functools32 14:38:58 INFO - Cleaning up... 14:38:58 INFO - Return code: 0 14:38:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f3f068f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2441240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', '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 14:38:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:38:58 INFO - Using env: {'DISPLAY': ':0', 14:38:58 INFO - 'HOME': '/home/cltbld', 14:38:58 INFO - 'LANG': 'en_US.UTF-8', 14:38:58 INFO - 'LANGUAGE': 'en_US:en', 14:38:58 INFO - 'LOGNAME': 'cltbld', 14:38:58 INFO - 'MAIL': '/var/mail/cltbld', 14:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:58 INFO - 'MOZ_NO_REMOTE': '1', 14:38:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:38:58 INFO - 'NO_EM_RESTART': '1', 14:38:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:58 INFO - 'PWD': '/builds/slave/test', 14:38:58 INFO - 'SHELL': '/bin/bash', 14:38:58 INFO - 'SHLVL': '1', 14:38:58 INFO - 'TERM': 'linux', 14:38:58 INFO - 'TMOUT': '86400', 14:38:58 INFO - 'USER': 'cltbld', 14:38:58 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:58 INFO - '_': '/tools/buildbot/bin/python'} 14:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:58 INFO - Downloading/unpacking flake8 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 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 14:38:58 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 14:39:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:39:00 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 14:39:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:39:00 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 14:39:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:00 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 14:39:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:39:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:39:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:39:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:39:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:39:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:39:01 INFO - no previously-included directories found matching 'docs/_build' 14:39:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:39:01 INFO - Running setup.py install for pep8 14:39:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:39:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:39:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:39:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:39:01 INFO - no previously-included directories found matching 'docs/_build' 14:39:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:39:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:39:01 INFO - Cleaning up... 14:39:01 INFO - Return code: 0 14:39:01 INFO - Running post-action listener: _resource_record_post_action 14:39:01 INFO - Running post-action listener: _start_resource_monitoring 14:39:01 INFO - Starting resource monitoring. 14:39:01 INFO - ##### 14:39:01 INFO - ##### Running install step. 14:39:01 INFO - ##### 14:39:01 INFO - Running pre-action listener: _resource_record_pre_action 14:39:01 INFO - Running main action method: install 14:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:01 INFO - Reading from file tmpfile_stdout 14:39:01 INFO - Detecting whether we're running mozinstall >=1.0... 14:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:39:01 INFO - Reading from file tmpfile_stdout 14:39:01 INFO - Output received: 14:39:01 INFO - Usage: mozinstall [options] installer 14:39:01 INFO - Options: 14:39:01 INFO - -h, --help show this help message and exit 14:39:01 INFO - -d DEST, --destination=DEST 14:39:01 INFO - Directory to install application into. [default: 14:39:01 INFO - "/builds/slave/test"] 14:39:01 INFO - --app=APP Application being installed. [default: firefox] 14:39:01 INFO - mkdir: /builds/slave/test/build/application 14:39:01 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'] 14:39:01 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 14:39:16 INFO - Reading from file tmpfile_stdout 14:39:16 INFO - Output received: 14:39:16 INFO - /builds/slave/test/build/application/firefox/firefox 14:39:16 INFO - Running post-action listener: _resource_record_post_action 14:39:16 INFO - ##### 14:39:16 INFO - ##### Running run-tests step. 14:39:16 INFO - ##### 14:39:16 INFO - Running pre-action listener: _resource_record_pre_action 14:39:16 INFO - Running main action method: run_tests 14:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:39:16 INFO - Python 2.7.3 14:39:16 INFO - Return code: 0 14:39:16 INFO - grabbing minidump binary from tooltool 14:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:39:16 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 0x24d00b0>, '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 0x24d0fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d1440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:39:16 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 14:39:16 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 14:39:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:39:16 INFO - Return code: 0 14:39:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:39:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:39:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:39:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:39:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:39:17 INFO - Return code: 0 14:39:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] in /builds/slave/test/build 14:39:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost 14:39:17 INFO - Using env: {'DISPLAY': ':0', 14:39:17 INFO - 'HOME': '/home/cltbld', 14:39:17 INFO - 'LANG': 'en_US.UTF-8', 14:39:17 INFO - 'LANGUAGE': 'en_US:en', 14:39:17 INFO - 'LOGNAME': 'cltbld', 14:39:17 INFO - 'MAIL': '/var/mail/cltbld', 14:39:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:39:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:17 INFO - 'MOZ_NO_REMOTE': '1', 14:39:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:17 INFO - 'NO_EM_RESTART': '1', 14:39:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:17 INFO - 'PWD': '/builds/slave/test', 14:39:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:39:17 INFO - 'SHELL': '/bin/bash', 14:39:17 INFO - 'SHLVL': '1', 14:39:17 INFO - 'TERM': 'linux', 14:39:17 INFO - 'TMOUT': '86400', 14:39:17 INFO - 'USER': 'cltbld', 14:39:17 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286', 14:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:17 INFO - '_': '/tools/buildbot/bin/python'} 14:39:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] with output_timeout 3600 14:39:17 INFO - mozversion INFO | application_buildid: 20151208131840 14:39:17 INFO - mozversion INFO | application_changeset: a8965ae93c5d098a4f91ad9da72150bb43df07a7 14:39:17 INFO - mozversion INFO | application_display_name: Nightly 14:39:17 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:39:17 INFO - mozversion INFO | application_name: Firefox 14:39:17 INFO - mozversion INFO | application_remotingname: firefox 14:39:17 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 14:39:17 INFO - mozversion INFO | application_vendor: Mozilla 14:39:17 INFO - mozversion INFO | application_version: 45.0a1 14:39:17 INFO - mozversion INFO | platform_buildid: 20151208131840 14:39:17 INFO - mozversion INFO | platform_changeset: a8965ae93c5d098a4f91ad9da72150bb43df07a7 14:39:17 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 14:39:17 INFO - mozversion INFO | platform_version: 45.0a1 14:39:17 INFO - 2015-12-08 14:39:17,354 DEBUG : using testdate: 1449614357 14:39:17 INFO - 2015-12-08 14:39:17,355 DEBUG : actual date: 1449614357 14:39:17 INFO - 2015-12-08 14:39:17,407 INFO : starting webserver on 'localhost:44424' 14:39:17 INFO - 2015-12-08 14:39:17,408 INFO : Starting test suite talos-linux64-ix-024.e 14:39:17 INFO - 2015-12-08 14:39:17,408 INFO : Starting test dromaeo_css 14:39:17 INFO - 2015-12-08 14:39:17,408 DEBUG : operating with platform_type : linux_ 14:39:17 INFO - 2015-12-08 14:39:17,409 INFO : Initialising browser for dromaeo_css test... 14:39:17 INFO - 2015-12-08 14:39:17,424 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgB4pj2/profile http://localhost:44424/getInfo.html 14:39:21 INFO - 2015-12-08 14:39:21,950 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:39:21 INFO - 2015-12-08 14:39:21,951 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:39:21 INFO - 2015-12-08 14:39:21,951 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:39:21 INFO - 2015-12-08 14:39:21,951 DEBUG : BROWSER_OUTPUT: __metrics 14:39:22 INFO - 2015-12-08 14:39:22,073 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] 14:39:22 INFO - 2015-12-08 14:39:22,963 INFO : Browser initialized. 14:39:22 INFO - 2015-12-08 14:39:22,964 INFO : Running cycle 1/1 for dromaeo_css test... 14:39:22 INFO - 2015-12-08 14:39:22,964 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgB4pj2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:39:35 INFO - 2015-12-08 14:39:35,041 DEBUG : BROWSER_OUTPUT: RSS: Main: 142835712 14:39:35 INFO - 2015-12-08 14:39:35,041 DEBUG : BROWSER_OUTPUT: 14:40:24 INFO - 2015-12-08 14:40:24,688 DEBUG : BROWSER_OUTPUT: 1449614424686 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] 14:42:36 INFO - 2015-12-08 14:42:36,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44424/tests/dromaeo/cssquery-ext.html) 14:42:37 INFO - 2015-12-08 14:42:37,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 147689472 14:42:37 INFO - 2015-12-08 14:42:37,130 DEBUG : BROWSER_OUTPUT: 14:45:39 INFO - 2015-12-08 14:45:39,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/dromaeo/cssquery-ext.html (next: http://localhost:44424/tests/dromaeo/cssquery-jquery.html) 14:45:39 INFO - 2015-12-08 14:45:39,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 145281024 14:45:39 INFO - 2015-12-08 14:45:39,697 DEBUG : BROWSER_OUTPUT: 14:48:41 INFO - 2015-12-08 14:48:41,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44424/tests/dromaeo/cssquery-mootools.html) 14:48:42 INFO - 2015-12-08 14:48:42,154 DEBUG : BROWSER_OUTPUT: RSS: Main: 144990208 14:48:42 INFO - 2015-12-08 14:48:42,154 DEBUG : BROWSER_OUTPUT: 14:51:43 INFO - 2015-12-08 14:51:43,943 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44424/tests/dromaeo/cssquery-prototype.html) 14:51:44 INFO - 2015-12-08 14:51:44,546 DEBUG : BROWSER_OUTPUT: RSS: Main: 144502784 14:51:44 INFO - 2015-12-08 14:51:44,546 DEBUG : BROWSER_OUTPUT: 14:54:47 INFO - 2015-12-08 14:54:47,157 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44424/tests/dromaeo/cssquery-yui.html) 14:54:47 INFO - 2015-12-08 14:54:47,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 144818176 14:54:47 INFO - 2015-12-08 14:54:47,758 DEBUG : BROWSER_OUTPUT: 14:57:50 INFO - 2015-12-08 14:57:50,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/dromaeo/cssquery-yui.html (next: http://localhost:44424/tests/dromaeo/cssquery-dojo.html) 14:57:50 INFO - 2015-12-08 14:57:50,449 DEBUG : BROWSER_OUTPUT: RSS: Main: 147140608 14:57:50 INFO - 2015-12-08 14:57:50,449 DEBUG : BROWSER_OUTPUT: 14:57:50 INFO - 2015-12-08 14:57:50,449 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:57:50 INFO - 2015-12-08 14:57:50,449 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:57:50 INFO - 2015-12-08 14:57:50,449 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:57:50 INFO - 2015-12-08 14:57:50,450 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:57:50 INFO - 2015-12-08 14:57:50,451 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2673.8796754146065;2698.9865050674766;2742.2458823823445;2748.40909204521;2758.3242105684103;4569.428821397325;4712.646551508634;4788;4794.47260801312;4850.660453768238;4663.790129444174;4678.041001594674;4679.906401871969;4712.552307530787;4891.804327826882;4247.15056988602;4346.15250026245;4397.186520493703;4403.141387429452;4434.201843668138;245.30276208564322;4348.97825510872;4447.221736196153;4448.666350023745;4459.219636563605;4186.267403204442;4289.2922667759785;4348.543402942709;4371.082072764723;4450.888727781799;4375.7593332366705;4384.430024096847;4414.977925110386;4415.425994620711;4442.755648439334;4120.320147175712;4368.890777730582;4370.562943705636;4370.694051416371;4436.201483732927;4589.655775816827;4706.317583950308;4770.284457331393;4770.76146192689;4792.496787837296;5121.692698438105;5135.4094279158;5137.101007323703;5139.306193663845;5140.871478213075;4892.63305252104;5010.674306170087;5141.408737995141;5161.509656582619;5167.224916262553;4704.364910737041;4784.6889952153;4786.5452781986005;4800.495947925488;4833.637477189225;5270.420253772082;5282.762275697526;5289.867753306121;5291.417944026154;5308.867278318073;4911.091448082117;5027.622928280393;5050.924236136461;5090.541851233407;5091.032703786269;4993.425756038029;5046.243063540425;5057.772400241998;5077.289179514871;5108.080545501845;5084.8220312288895;5111.437741848394;5137.614678899097;5148.30497882781;5192.9614077184715;4648.651351148677;4788.784504697297;4953.925691114636;5114.616403769658;5115.590752739772;4218.261804184317;4233.259179643612;4252.702310838212;4278.529361770203;4279.443672322578;3716.1452865841006;3717.6096509866074;3728.179800443898;3732.3654978653153;3742.476053352478;4209.536950935395;4270.7010509264055;4339.522652508222;4383.978080109579;4398.186335527937;5131.435542090367;5138.58891288696;5143.12566863634;5145.76844042019;5165.251038599382;4343.305071188594;4370.8033138508845;4382.123575284892;4389.297712366006;4402.713823601455;4311.159323931804;4408.4930233023615;4460.977695111568;4546.818127274872;4584.106099310669;4723.055388922161;4734.21885388907;4746.288056791509;4757.762111894392;4767.904641907143;4954.5540901319055;5074.67014644047;5075.822346217865;5081.441041485507;5126.56424203932;4683.976580117078;4734.455537613218;4749.026449577759;4760.6429517787;4794.880127996828;5002.949970500394;5037.0681423936685;5072.188449848007;5074.340335756476;5116.897662046813;4908.141075311878;5057.924131137962;5109.718965456936;5160.793568257228;5204.37547494288;4867.318575399518;4924.803007879788;4938.789996450892;4949.653524253267;4975.626827987988;4950.059488697136;4992.201247800334;5006.749662516932;5006.774695138654;5008.69947803133;4738.97630511859;4832.371791667061;4839.225723884302;4899.681520701143;4957.652964292609;4941.925871112008;4961;4963.230699241623;4974.427940786856;5017.498250174954;4781.330613714153;4846.80612775485;4857.562819346276;4866.343043689057;4926.3842019747535 14:57:50 INFO - 2015-12-08 14:57:50,451 DEBUG : BROWSER_OUTPUT: |1;ext.html;511.2969666708278;539.9271098401715;540.9242706021156;550.3698265486018;551.3549147497428;26464.73535264649;27042.459150816972;34894.651053489455;35391.469127963035;35420.11449713758;39178;39506.60493395065;39574.20851582967;39631.405528917014;39650.40524392129;7949.165337639552;8125.593720313961;8134.186581341878;8145.674173033071;8161.143079976606;7875.212478752136;7987.281144696976;7987.440879138463;7993.200679932019;8001.159878212791;7999.160088190743;8023.638936247854;8099.190080991883;8105.554194519299;8105.75682729519;7964.8805267921025;7977.760667179994;8020;8033.357331413473;8058.11360750317;7855.489393189481;7903.36773058154;7910.4462687611895;7963.641636126388;7999.240072193133;36127.81936090329;36539.63460365389;36601;36770.63229367699;36773.81613091944;2779.596958441035;2883.5818806273182;3102.6276846778305;3423.8288085595623;3444;27828.165155045383;27836.582451263246;27850.5822412664;27932.58101128485;28033.57949630757;3354.4465163248033;3411.7441191910457;3431.8815235804996;3473.513708080871;3546.2198316370614;212841;213417;213581;214626;214628;46486.5351346489;48041;56473.71763141158;57819;57862;48739.756301218265;48969.75515122473;49123;49158.26262606064;49192;12716.491340346283;12756.617301480785;12773.936130319289;12848;12873.163244389272;9399.483028433366;9445.480498572644;9461.574229159703;9463.148316651534;9469.337146399823;18599.25602975893;18897.33859314945;18953.620927581647;19027.429177124708;19035.1434185462;7172.748953786592;7360.374368178765;7416.22129676387;7419;7459.291367320096;784.6759735196663;798.5647821937058;854.7435769269194;890.2210565754964;933.8132373525322;24867.875660621943;26066.609000865003;26329.868350658126;27181;27385.726142738316;887.4364778365655;923.8383282925461;940.7365937537501;946.3895787217207;1030.5465595138114;11602.883971160349;11645.12661550387;11792;12154.209976351509;12368.44342004612;247975;248539;248666;250727.98544029018;251293;44834.32748508775;45119;45338.773306133255;45358;45398.319025214645;1223.804191329383;1225.66906935127;1226.4235809169677;1251.355551890777;1254.9749005019848;21778.12887484546;22023;22088.77911220867;22265.109395623993;23158.305250842503;37730.24539509249;38304.616953830104;38382.42426363551;38512.22975540417;38643.42034869423;237852;240112;240967;241396;242423.51517697502;28399;28608;29209.415811684074;29241.561376579793;29352.853235733684;34756.65243347534;35001.824990874884;37016;37363.2527349446;37547.436788448744;31107;31702.84148579242;31949.840250799527;32249.51625725663;32432.189195270308;28790.856045720477;29080.418391631625;31971.360572787948;33722.49416258709;33890.49164262489;29694.703052969195;29900.252493687833;29955.70044299529;30086;30096.398072038875;27393.452130957667;29029.564556531248;29293.560596591495;29674.406511870075;30685.693143068285;21778.847113791664;23346.416339590967;23766.405839854142;23908.282751517483;23957.880210598836 14:57:50 INFO - 2015-12-08 14:57:50,454 DEBUG : BROWSER_OUTPUT: |2;jquery.html;277;281.1242978123146;281.30237012209733;283.16325258860064;286.91105757215263;13145.474181032747;13298.601041968732;14645.26773661318;15075.698486030287;15199.164045977466;8594.312455003601;8848.867266991001;9449.196818270439;9556.42661440314;9670.032996700327;4290.249206388878;4366.323219900904;4377.912441751163;4382.517923028464;4386.868393948187;3496.9300613987707;3609.169890925089;4399.296112621981;4808.447028591704;4991.376077990251;4954.554090131887;4973.204287314031;4974.950250497485;4991.450940396553;4993.201087825949;4893.535114164149;4931.3835770528685;5709.486146246837;5721.513671337942;5725.3988331225455;5041.747912604355;5054.646174767768;5056.115179843513;5060.51925067118;5060.645754797166;10982.505787239514;10989.06592939601;11001.22991390603;11168.218224724273;15024.624384390369;1766.143420441085;1831.2034265094726;1835.2750663487982;1920.5198700324918;2005.177877070394;8789.824203515958;8805.16350946659;9651.71044868655;9807.90192098077;12858.164219325807;1656.5941344370585;1668.1742537443922;1674.5897255172438;1692.069361850977;1707.7779888614525;51015;51486;51569.74215128938;52785;59007.81984360332;9399.953000234955;9589.376690515093;9726.75683107928;9727.319087663936;9739.464329461805;11859.288442693465;11913;11934.582289619822;11934.701632459259;12022.939885300517;7115.217326094125;7139.143302803697;7156.642167891585;7163.462740294499;7208.207097219301;6716.46268298535;6725.260221375743;6746.325367463312;6754.527183097136;6787;4015.6185162409524;4068.2066996935314;4081.836726530965;4108.835646574164;4137.855175068858;1676.7652528645756;1696.5334533003522;1719.9914000429917;1737.4189487566255;1746.275295752274;726.5894769455241;757.2957149850691;825.3520986025941;838.9973981092536;956.7560272130562;13690.52083177084;14246.358913848902;14353.784693229401;14536.491222807152;14615.488457904135;831.0899564976341;848.3637272045966;857.8455877942031;887.9156480134377;939.492673956056;8200.835983280302;9243.121903419164;9243.953780231055;9288.34981551285;9407.858882116774;476772;481807;484498;492935;494488;70985;73804;73877;74864;76299;1025.8102251083574;1057.4131357096885;1062.8937106289463;1065.1798115451058;1069;14838.40646374133;14890.627734306729;14906.925465372604;15023.549293521211;15418.30617622232;33428;33753.32493350168;33861.49207761935;34558.654413455544;34720;43763.78118109389;45389;45978.31032534448;46922.53077469182;47406.52593474021;8206.179382061746;8287.751367458986;8312.625931833203;8375.832483350421;8377.70678026266;9831.803363932539;9906.851397228904;14313.427462901784;14390.928045359706;15133.470328538448;12883.291418972047;12904.8064279034;12958.092933494565;13150.07949443568;13332.666683332995;12433.440495177558;12652.304123273309;12794.360281985677;12916.677083072622;13033.674158146123;12707.491700331882;12931.741365172831;13020.674483137997;13207.60377188686;13306;8287.544185069879;8292.502449853027;8410.369222308229;8465.449745766506;8513.148685131686;8758.912410876064;8850.867236991578;12813.423395947018;13534.59396218115;13994.65013374633 14:57:50 INFO - 2015-12-08 14:57:50,456 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1469.9930547574918;1657.2542355939827;1717.450415866923;1718.458685514063;1747.4058820001196;5875.324337701166;6049.697515124249;7182.748603798868;7462.999999999994;7468.103827540696;6866.416354609852;7134.0369050178215;7170.498065135443;7198.712051517933;7266.96366518168;2012.7987201279902;2022.8280596149345;2028.8782673039666;2041.061111888533;2046.3451695457459;1995.3215906591756;2000.30989308689;2007.5282308657454;2052.302217246136;2054.979450205494;1975.4073777866654;2011.788762179972;2039.20471016303;2040.7040979058027;2043.795620437959;2041.8876961767096;2063.030375723408;2064.783197764228;2072.8445366597566;2082.4585607741947;2003.91984320627;2009.4976255936017;2018.6669199582052;2039.520712632545;2077.1898959405844;7119.53723008008;7169.533980291264;7179.210286868441;7189.532680375811;7200.963995180043;4060.898477538085;4100.17996400721;4109.404136400205;4110.424540564323;4117.464729585165;2671.051776619311;2678.464307138561;2696.730326967307;2750.2024412920227;2750.4636595863813;770.8728059870115;772.3898120484811;773.9419543534258;805.2189376304975;831.6257684042145;9390.85913711295;9465.66870159541;9480.668176613854;9488.28837837165;9498.620055197714;3727.1986522897705;3732.776033437948;3766.0208345830283;3780.1683629601443;3790.639889210521;8196.672133114727;8204.753857384288;8209.58952052395;8216.917830821734;8259;4062;4071.185762847383;4073.5926407359025;4082.6937979651643;4084.8366065357645;3158.699923507263;3245.496947973068;3694.3350196964802;3702.1670124221832;3709.8330575123646;3343.4984752286864;3369.814660193713;3372.8144952027874;3401.4217583010945;3434.587849458031;1039.953202105907;1043.6555936540924;1046.727850758793;1050.4537640426936;1050.4590136079926;984.5077461269366;1023.2888142740724;1027.5786927359895;1028.2082796246848;1057.8413238014205;6596.4393026592315;6629.303923088103;6631.602103873783;6658.86682266352;6669.533132680665;392.6466180437629;397.191714860258;1072.9068603278624;1122.1920217443428;1125.5497800879714;5207.843764687065;5229.633925625246;5242.161254199386;5430.8913821723345;5622.662640241599;8153;8253;8273.627686754111;8278;8296.875546866802;8206.261436470746;8216.21945915137;8224.506529608243;8230.588470576447;8536.061033286334;6690.397864192246;6712.362325579063;6743.190817101881;6774.220964589135;6794.592324460548;6543.247526534319;6653.866922661423;6665.266820649822;6692.230393504809;6727.663616819042;7269.200387957426;7768.88346674789;7774.067111946602;7784.532928024337;7836.09884863248;7682.8079298018;7736.92263077362;7796.610169491616;7810.336121429515;7901.644426000728;5676.2337084493065;5939.316978547522;6011.977963746086;6319.873602528016;6370.108184854032;6538.1500404947055;6539.346065393423;6545.5090868184125;6547.836304092436;6564.376384243489;6107;6282.8429289266305;6284.24589049317;6322.494200464043;6393.29673735898;6215.81352559424;6246.219222597176;6259.2488901332135;6334.619922804646;6351.841203969938;6150.954337762501;6192.81421557354;6196.721147548281;6212.751489940351;6214.067889816563;5857.092150716646;5868.794592189253;5879.412058794086;5886.20536227621;5890.793822216202;5707.971460142673;5776.624519406225;5795.304563452412;5815.33123690764;5816.5055970243 14:57:50 INFO - 2015-12-08 14:57:50,456 DEBUG : BROWSER_OUTPUT: |4;prototype.html;246.83092081923883;255.04231610303302;256.6650521070004;257.0975874679873;261.2997167590856;5495.395506494292;5598.068666310127;5651.660900345983;5659.122835960433;5691;5432.75552600133;5583.302087239095;5586.720663966806;5597.888042239153;5612.943870561293;4157.147784704143;4177.456930599025;4182.2890108681595;4188.916221675565;4189.455370801791;4155.210510003105;4160.791960401983;4161.791910404483;4185.225733239346;4189.664826813848;3969.4839670842894;4074.3684728867074;4131.958680413202;4140;4140.378943158536;4031.1937612477623;4044.5348784889675;4050.9137794036096;4097.692673049503;4104.548499665035;3484.790912545255;3488.284901595167;3490.8603655853735;3491;3508.28080243552;5378.569714422837;5385.434529374437;5386.973065134688;5389.353277606673;5410.08028635133;4487.282034874404;4704.411948506437;4718.693284936502;4723.173444647173;4733.5976442002475;5715.457031581993;5833.387494313079;5846.269216347957;5854.76580936762;5864.501517371029;3787.9810600947094;3796.9810150949343;3797.6012518685693;3797.6202379761803;3800.524934383202;6121.938780612226;6160.6611636359985;6198.690065496708;6210.192674952273;6218.844528886814;3767.9449754068905;3801.334766415866;3807.276617442677;3811.0662887592716;3883.5922228165637;3944.3491823848744;3955.3869150281175;3957.584453632385;3958.604139586076;3977.7812220327583;4680.461746899082;4685.484596694361;4687.250039993584;4690.81236750533;4698.765061746967;5893.11603259506;5899.144624029492;5906.675132867734;5908.113782932594;5925.081612350093;1353.9932300338633;1381.0884816021378;1385.8752712255946;1386.3207028556137;1387.4172847404116;878.872563478292;886.4902680958475;896.4845214001975;900.8153328567628;916.1662886773005;5064.721440320818;5070.797168113234;5084.923726144111;5089.338386009795;5106.4893510648635;6064.120702498113;6068.666223357758;6074.939250607437;6079.635221886701;6094.299155597163;5021.648484606116;5071.949280507221;5071.974640126849;5076.771545280471;5077.974610126926;3222.9033129006166;3243.6756324367375;3286.2441638423297;3299.0762586475826;3312.420326442863;5791.768329266866;5794.594378393556;5797.91303130445;5805.82582522525;5813.09896965971;6332.715027823667;6386.808395748135;6391.073294372383;6397.96801015992;6419.967900160469;5610.298712660918;5711.9714401428555;5750.568707346965;5765;5777.364489906191;6181.84545386369;6186.1339412483185;6196.938030619816;6200.441960223421;6209.0996805462055;6076.088586712029;6081.118237855575;6084.026555751058;6093.238345206849;6100;5760.193572899713;5768.596198266249;5770.740316685676;5773.913391299218;5783.942160578508;3811.294910441577;3900.4929359183125;3929.685625149924;3934.11482416454;3959.564447910785;6082.665453400105;6119.2350956130485;6151.477124444473;6154.046122850787;6160.599561028519;5894.587378883437;5900.793472228452;5905;5906.468417842415;5906.70466476683;5808.215890854681;5904.822855314347;5905.734241959208;5967.76128954837;5985.940140598538;5783.971080144573;5803.854903627274;5819.621724587888;5827.912581311199;5842.357340692435;5994.400559943971;5997.790077347272;6005.249343832021;6009.158717779602;6009.308929473166;5747.655140691572;5820.476157145878;5845.035569131046;5854.443827836349;5876.08920617305 14:57:50 INFO - 2015-12-08 14:57:50,457 DEBUG : BROWSER_OUTPUT: |5;yui.html;658.9802305930821;676.7766637009787;682.8019874236471;708.6492186367749;722.8554289142166;11313.472681188037;11355.148363872711;11388.54445822166;11524.078073754112;11553.884461155396;11353.091752659788;11445.542178312879;11480.196386252966;13652.180869147858;13958.302084895766;788.357488646754;796.3947399976031;802.4783890471182;809.017044291186;812.2689579378548;798.0383637716567;800.7277525641281;805.5770720371793;805.605253425823;805.9677612895478;837.2632083766277;843.4053991935671;844.2022288936957;844.3414136973171;846.4878748357216;835.5822088955522;836.4354061008825;837.0499483086679;837.8031162676766;841.9031811341682;622.0141076393921;622.6668732228281;623.323693792236;624.665803794972;625.1622825413922;11313.15151363651;11372.090232781358;11389.088872890148;11389.202755807097;11446.484908179153;10478.528466219039;10688.358698478116;10988.285761425483;11016.669499915015;11254.324740515513;9080.500572468512;9105.63577456901;9132.36073474857;9258.72223833286;9378.202852757524;3212.229065024401;3266.3630592034565;3266.4610339293986;3271.1167984644253;3271.247613048988;40053.39919901204;40434.39348409776;40596.188076238606;40735.59264407348;40868.59131408678;8763.74756521263;8936.8659470108;8982.146696063994;8986.910130898737;9068.410553314014;15686.215689215494;15686.529404117895;15705.842941570667;15732.842671573138;15756.212189390484;5871.1486834409625;6064.9090263646085;6267.811965641038;6451.483881289486;6487.961926091897;3440.776349537272;3484.0767196692896;3504.6144924058844;3509.1051781795477;3546.2730140321173;2627.6846778386716;2664.7335266473196;2685.44948285601;2694.474577457416;2696.770774484191;466.22606473254234;475.0996860948552;476.25941660717916;477.21974571575726;477.2411865134453;418.36408658838394;432.63658526837605;533.8958903013875;557.5483858074972;571.5656101362994;7349.595772232578;7872.881906771288;7907.169747176464;7941.245581669732;8044.597770111471;466.6453495343495;542.4548328929479;604.7611193578512;609.7713357490941;611.9357467465941;3624.5831729350934;3702.8703995360033;3763.2849758546336;3782.6028267031566;3801.2777572261184;47390.76304618455;52192.47807521952;52211;52536.211956820676;52804;42971.35542966858;43164.13671726548;43603.781981089895;43641.56358436375;44745.77627111909;39903.60096399057;40224.396634050514;40480.39279410811;40926.795366022976;41436.79281603633;7533.472656913963;7776.533407995538;7906.881396779168;8090.959545202471;8211.876821847558;31057.844710776302;31275.218119547193;31551.84224078865;31838.840805795822;32064.679353207102;35031.12422189466;35093.64906350904;35547;38589.4211586832;39877;10394.792104158027;10664.146868250677;10844;11165.106791456501;11247.550097995989;10633.149348051982;10882.564697412015;10939.726506837074;11088.777052336656;11439.59961401347;10398.740031499274;10789.082927951213;10931.125509959344;11029;11117.388543630179;10331;10979.011888930034;10984.450777461256;11104.5558177672;11132.666020019413;10110;10362.844557331797;10571.04860562553;10902.672919812418;10940.39827809478;9198.95400522993;9446.717754135248;9636.566354513923;9640.132388085107;9835.557399916877;8680.609372578376;8698.869516957377;9305.720828375159;9390.248780097712;9446.38598491096 14:57:50 INFO - 2015-12-08 14:57:50,457 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:57:50 INFO - 2015-12-08 14:57:50,457 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:57:50 INFO - 2015-12-08 14:57:50,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,324 14:57:50 INFO - 2015-12-08 14:57:50,457 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:57:50 INFO - 2015-12-08 14:57:50,458 DEBUG : BROWSER_OUTPUT: __startTimestamp1449615470447__endTimestamp 14:57:50 INFO - 2015-12-08 14:57:50,458 DEBUG : BROWSER_OUTPUT: 14:57:50 INFO - 2015-12-08 14:57:50,458 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:57:50 INFO - 2015-12-08 14:57:50,458 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:57:50 INFO - 2015-12-08 14:57:50,458 DEBUG : BROWSER_OUTPUT: 14:57:50 INFO - 2015-12-08 14:57:50,458 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4665.62 Median:4792.50 stddev:604.85 (12.6%) stddev-sans-first:586.17 14:57:50 INFO - 2015-12-08 14:57:50,458 DEBUG : BROWSER_OUTPUT: Values: 2673.9 2699.0 2742.2 2748.4 2758.3 4569.4 4712.6 4788.0 4794.5 4850.7 4663.8 4678.0 4679.9 4712.6 4891.8 4247.2 4346.2 4397.2 4403.1 4434.2 245.3 4349.0 4447.2 4448.7 4459.2 4186.3 4289.3 4348.5 4371.1 4450.9 4375.8 4384.4 4415.0 4415.4 4442.8 4120.3 4368.9 4370.6 4370.7 4436.2 4589.7 4706.3 4770.3 4770.8 4792.5 5121.7 5135.4 5137.1 5139.3 5140.9 4892.6 5010.7 5141.4 5161.5 5167.2 4704.4 4784.7 4786.5 4800.5 4833.6 5270.4 5282.8 5289.9 5291.4 5308.9 4911.1 5027.6 5050.9 5090.5 5091.0 4993.4 5046.2 5057.8 5077.3 5108.1 5084.8 5111.4 5137.6 5148.3 5193.0 4648.7 4788.8 4953.9 5114.6 5115.6 4218.3 4233.3 4252.7 4278.5 4279.4 3716.1 3717.6 3728.2 3732.4 3742.5 4209.5 4270.7 4339.5 4384.0 4398.2 5131.4 5138.6 5143.1 5145.8 5165.3 4343.3 4370.8 4382.1 4389.3 4402.7 4311.2 4408.5 4461.0 4546.8 4584.1 4723.1 4734.2 4746.3 4757.8 4767.9 4954.6 5074.7 5075.8 5081.4 5126.6 4684.0 4734.5 4749.0 4760.6 4794.9 5002.9 5037.1 5072.2 5074.3 5116.9 4908.1 5057.9 5109.7 5160.8 5204.4 4867.3 4924.8 4938.8 4949.7 4975.6 4950.1 4992.2 5006.7 5006.8 5008.7 4739.0 4832.4 4839.2 4899.7 4957.7 4941.9 4961.0 4963.2 4974.4 5017.5 4781.3 4846.8 4857.6 4866.3 4926.4 14:57:50 INFO - 2015-12-08 14:57:50,458 DEBUG : BROWSER_OUTPUT: 14:57:50 INFO - 2015-12-08 14:57:50,458 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38777.18 Median:3458.76 stddev:61177.02 (1768.8%) stddev-sans-first:61281.17 14:57:50 INFO - 2015-12-08 14:57:50,459 DEBUG : BROWSER_OUTPUT: Values: 511.3 539.9 540.9 550.4 551.4 26464.7 27042.5 34894.7 35391.5 35420.1 39178.0 39506.6 39574.2 39631.4 39650.4 7949.2 8125.6 8134.2 8145.7 8161.1 7875.2 7987.3 7987.4 7993.2 8001.2 7999.2 8023.6 8099.2 8105.6 8105.8 7964.9 7977.8 8020.0 8033.4 8058.1 7855.5 7903.4 7910.4 7963.6 7999.2 36127.8 36539.6 36601.0 36770.6 36773.8 2779.6 2883.6 3102.6 3423.8 3444.0 27828.2 27836.6 27850.6 27932.6 28033.6 3354.4 3411.7 3431.9 3473.5 3546.2 212841.0 213417.0 213581.0 214626.0 214628.0 46486.5 48041.0 56473.7 57819.0 57862.0 48739.8 48969.8 49123.0 49158.3 49192.0 12716.5 12756.6 12773.9 12848.0 12873.2 9399.5 9445.5 9461.6 9463.1 9469.3 18599.3 18897.3 18953.6 19027.4 19035.1 7172.7 7360.4 7416.2 7419.0 7459.3 784.7 798.6 854.7 890.2 933.8 24867.9 26066.6 26329.9 27181.0 27385.7 887.4 923.8 940.7 946.4 1030.5 11602.9 11645.1 11792.0 12154.2 12368.4 247975.0 248539.0 248666.0 250728.0 251293.0 44834.3 45119.0 45338.8 45358.0 45398.3 1223.8 1225.7 1226.4 1251.4 1255.0 21778.1 22023.0 22088.8 22265.1 23158.3 37730.2 38304.6 38382.4 38512.2 38643.4 237852.0 240112.0 240967.0 241396.0 242423.5 28399.0 28608.0 29209.4 29241.6 29352.9 34756.7 35001.8 37016.0 37363.3 37547.4 31107.0 31702.8 31949.8 32249.5 32432.2 28790.9 29080.4 31971.4 33722.5 33890.5 29694.7 29900.3 29955.7 30086.0 30096.4 27393.5 29029.6 29293.6 29674.4 30685.7 21778.8 23346.4 23766.4 23908.3 23957.9 14:57:50 INFO - 2015-12-08 14:57:50,460 DEBUG : BROWSER_OUTPUT: 14:57:50 INFO - 2015-12-08 14:57:50,460 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25795.83 Median:24894.15 stddev:79529.92 (319.5%) stddev-sans-first:79729.94 14:57:50 INFO - 2015-12-08 14:57:50,460 DEBUG : BROWSER_OUTPUT: Values: 277.0 281.1 281.3 283.2 286.9 13145.5 13298.6 14645.3 15075.7 15199.2 8594.3 8848.9 9449.2 9556.4 9670.0 4290.2 4366.3 4377.9 4382.5 4386.9 3496.9 3609.2 4399.3 4808.4 4991.4 4954.6 4973.2 4975.0 4991.5 4993.2 4893.5 4931.4 5709.5 5721.5 5725.4 5041.7 5054.6 5056.1 5060.5 5060.6 10982.5 10989.1 11001.2 11168.2 15024.6 1766.1 1831.2 1835.3 1920.5 2005.2 8789.8 8805.2 9651.7 9807.9 12858.2 1656.6 1668.2 1674.6 1692.1 1707.8 51015.0 51486.0 51569.7 52785.0 59007.8 9400.0 9589.4 9726.8 9727.3 9739.5 11859.3 11913.0 11934.6 11934.7 12022.9 7115.2 7139.1 7156.6 7163.5 7208.2 6716.5 6725.3 6746.3 6754.5 6787.0 4015.6 4068.2 4081.8 4108.8 4137.9 1676.8 1696.5 1720.0 1737.4 1746.3 726.6 757.3 825.4 839.0 956.8 13690.5 14246.4 14353.8 14536.5 14615.5 831.1 848.4 857.8 887.9 939.5 8200.8 9243.1 9244.0 9288.3 9407.9 476772.0 481807.0 484498.0 492935.0 494488.0 70985.0 73804.0 73877.0 74864.0 76299.0 1025.8 1057.4 1062.9 1065.2 1069.0 14838.4 14890.6 14906.9 15023.5 15418.3 33428.0 33753.3 33861.5 34558.7 34720.0 43763.8 45389.0 45978.3 46922.5 47406.5 8206.2 8287.8 8312.6 8375.8 8377.7 9831.8 9906.9 14313.4 14390.9 15133.5 12883.3 12904.8 12958.1 13150.1 13332.7 12433.4 12652.3 12794.4 12916.7 13033.7 12707.5 12931.7 13020.7 13207.6 13306.0 8287.5 8292.5 8410.4 8465.4 8513.1 8758.9 8850.9 12813.4 13534.6 13994.7 14:57:50 INFO - 2015-12-08 14:57:50,460 DEBUG : BROWSER_OUTPUT: 14:57:50 INFO - 2015-12-08 14:57:50,460 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4895.70 Median:5915.06 stddev:2550.35 (43.1%) stddev-sans-first:2544.51 14:57:50 INFO - 2015-12-08 14:57:50,461 DEBUG : BROWSER_OUTPUT: Values: 1470.0 1657.3 1717.5 1718.5 1747.4 5875.3 6049.7 7182.7 7463.0 7468.1 6866.4 7134.0 7170.5 7198.7 7267.0 2012.8 2022.8 2028.9 2041.1 2046.3 1995.3 2000.3 2007.5 2052.3 2055.0 1975.4 2011.8 2039.2 2040.7 2043.8 2041.9 2063.0 2064.8 2072.8 2082.5 2003.9 2009.5 2018.7 2039.5 2077.2 7119.5 7169.5 7179.2 7189.5 7201.0 4060.9 4100.2 4109.4 4110.4 4117.5 2671.1 2678.5 2696.7 2750.2 2750.5 770.9 772.4 773.9 805.2 831.6 9390.9 9465.7 9480.7 9488.3 9498.6 3727.2 3732.8 3766.0 3780.2 3790.6 8196.7 8204.8 8209.6 8216.9 8259.0 4062.0 4071.2 4073.6 4082.7 4084.8 3158.7 3245.5 3694.3 3702.2 3709.8 3343.5 3369.8 3372.8 3401.4 3434.6 1040.0 1043.7 1046.7 1050.5 1050.5 984.5 1023.3 1027.6 1028.2 1057.8 6596.4 6629.3 6631.6 6658.9 6669.5 392.6 397.2 1072.9 1122.2 1125.5 5207.8 5229.6 5242.2 5430.9 5622.7 8153.0 8253.0 8273.6 8278.0 8296.9 8206.3 8216.2 8224.5 8230.6 8536.1 6690.4 6712.4 6743.2 6774.2 6794.6 6543.2 6653.9 6665.3 6692.2 6727.7 7269.2 7768.9 7774.1 7784.5 7836.1 7682.8 7736.9 7796.6 7810.3 7901.6 5676.2 5939.3 6012.0 6319.9 6370.1 6538.2 6539.3 6545.5 6547.8 6564.4 6107.0 6282.8 6284.2 6322.5 6393.3 6215.8 6246.2 6259.2 6334.6 6351.8 6151.0 6192.8 6196.7 6212.8 6214.1 5857.1 5868.8 5879.4 5886.2 5890.8 5708.0 5776.6 5795.3 5815.3 5816.5 14:57:50 INFO - 2015-12-08 14:57:50,461 DEBUG : BROWSER_OUTPUT: 14:57:50 INFO - 2015-12-08 14:57:50,461 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4803.00 Median:5604.18 stddev:1506.70 (26.9%) stddev-sans-first:1471.61 14:57:50 INFO - 2015-12-08 14:57:50,461 DEBUG : BROWSER_OUTPUT: Values: 246.8 255.0 256.7 257.1 261.3 5495.4 5598.1 5651.7 5659.1 5691.0 5432.8 5583.3 5586.7 5597.9 5612.9 4157.1 4177.5 4182.3 4188.9 4189.5 4155.2 4160.8 4161.8 4185.2 4189.7 3969.5 4074.4 4132.0 4140.0 4140.4 4031.2 4044.5 4050.9 4097.7 4104.5 3484.8 3488.3 3490.9 3491.0 3508.3 5378.6 5385.4 5387.0 5389.4 5410.1 4487.3 4704.4 4718.7 4723.2 4733.6 5715.5 5833.4 5846.3 5854.8 5864.5 3788.0 3797.0 3797.6 3797.6 3800.5 6121.9 6160.7 6198.7 6210.2 6218.8 3767.9 3801.3 3807.3 3811.1 3883.6 3944.3 3955.4 3957.6 3958.6 3977.8 4680.5 4685.5 4687.3 4690.8 4698.8 5893.1 5899.1 5906.7 5908.1 5925.1 1354.0 1381.1 1385.9 1386.3 1387.4 878.9 886.5 896.5 900.8 916.2 5064.7 5070.8 5084.9 5089.3 5106.5 6064.1 6068.7 6074.9 6079.6 6094.3 5021.6 5071.9 5072.0 5076.8 5078.0 3222.9 3243.7 3286.2 3299.1 3312.4 5791.8 5794.6 5797.9 5805.8 5813.1 6332.7 6386.8 6391.1 6398.0 6420.0 5610.3 5712.0 5750.6 5765.0 5777.4 6181.8 6186.1 6196.9 6200.4 6209.1 6076.1 6081.1 6084.0 6093.2 6100.0 5760.2 5768.6 5770.7 5773.9 5783.9 3811.3 3900.5 3929.7 3934.1 3959.6 6082.7 6119.2 6151.5 6154.0 6160.6 5894.6 5900.8 5905.0 5906.5 5906.7 5808.2 5904.8 5905.7 5967.8 5985.9 5784.0 5803.9 5819.6 5827.9 5842.4 5994.4 5997.8 6005.2 6009.2 6009.3 5747.7 5820.5 5845.0 5854.4 5876.1 14:57:50 INFO - 2015-12-08 14:57:50,462 DEBUG : BROWSER_OUTPUT: 14:57:50 INFO - 2015-12-08 14:57:50,462 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12183.59 Median:21694.86 stddev:13756.12 (63.4%) stddev-sans-first:13767.48 14:57:50 INFO - 2015-12-08 14:57:50,462 DEBUG : BROWSER_OUTPUT: Values: 659.0 676.8 682.8 708.6 722.9 11313.5 11355.1 11388.5 11524.1 11553.9 11353.1 11445.5 11480.2 13652.2 13958.3 788.4 796.4 802.5 809.0 812.3 798.0 800.7 805.6 805.6 806.0 837.3 843.4 844.2 844.3 846.5 835.6 836.4 837.0 837.8 841.9 622.0 622.7 623.3 624.7 625.2 11313.2 11372.1 11389.1 11389.2 11446.5 10478.5 10688.4 10988.3 11016.7 11254.3 9080.5 9105.6 9132.4 9258.7 9378.2 3212.2 3266.4 3266.5 3271.1 3271.2 40053.4 40434.4 40596.2 40735.6 40868.6 8763.7 8936.9 8982.1 8986.9 9068.4 15686.2 15686.5 15705.8 15732.8 15756.2 5871.1 6064.9 6267.8 6451.5 6488.0 3440.8 3484.1 3504.6 3509.1 3546.3 2627.7 2664.7 2685.4 2694.5 2696.8 466.2 475.1 476.3 477.2 477.2 418.4 432.6 533.9 557.5 571.6 7349.6 7872.9 7907.2 7941.2 8044.6 466.6 542.5 604.8 609.8 611.9 3624.6 3702.9 3763.3 3782.6 3801.3 47390.8 52192.5 52211.0 52536.2 52804.0 42971.4 43164.1 43603.8 43641.6 44745.8 39903.6 40224.4 40480.4 40926.8 41436.8 7533.5 7776.5 7906.9 8091.0 8211.9 31057.8 31275.2 31551.8 31838.8 32064.7 35031.1 35093.6 35547.0 38589.4 39877.0 10394.8 10664.1 10844.0 11165.1 11247.6 10633.1 10882.6 10939.7 11088.8 11439.6 10398.7 10789.1 10931.1 11029.0 11117.4 10331.0 10979.0 10984.5 11104.6 11132.7 10110.0 10362.8 10571.0 10902.7 10940.4 9199.0 9446.7 9636.6 9640.1 9835.6 8680.6 8698.9 9305.7 9390.2 9446.4 14:57:50 INFO - 2015-12-08 14:57:50,462 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:57:50 INFO - 2015-12-08 14:57:50,462 DEBUG : BROWSER_OUTPUT: 14:57:51 INFO - 2015-12-08 14:57:51,167 INFO : Browser exited with error code: 0 14:57:51 INFO - 2015-12-08 14:57:51,191 INFO : Completed test dromaeo_css (00:18:33) 14:57:51 INFO - 2015-12-08 14:57:51,191 INFO : Starting test kraken 14:57:51 INFO - 2015-12-08 14:57:51,191 DEBUG : operating with platform_type : linux_ 14:57:51 INFO - 2015-12-08 14:57:51,191 INFO : Initialising browser for kraken test... 14:57:51 INFO - 2015-12-08 14:57:51,197 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHQcAKC/profile http://localhost:44424/getInfo.html 14:57:55 INFO - 2015-12-08 14:57:55,809 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:57:55 INFO - 2015-12-08 14:57:55,809 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:57:55 INFO - 2015-12-08 14:57:55,809 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:57:55 INFO - 2015-12-08 14:57:55,809 DEBUG : BROWSER_OUTPUT: __metrics 14:57:55 INFO - 2015-12-08 14:57:55,918 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] 14:57:56 INFO - 2015-12-08 14:57:56,851 INFO : Browser initialized. 14:57:56 INFO - 2015-12-08 14:57:56,852 INFO : Running cycle 1/1 for kraken test... 14:57:56 INFO - 2015-12-08 14:57:56,852 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHQcAKC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:58:08 INFO - 2015-12-08 14:58:08,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 143585280 14:58:08 INFO - 2015-12-08 14:58:08,933 DEBUG : BROWSER_OUTPUT: 14:58:11 INFO - 2015-12-08 14:58:11,582 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44424/tests/kraken/driver.html?testName=audio-beat-detection) 14:58:12 INFO - 2015-12-08 14:58:12,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 143052800 14:58:12 INFO - 2015-12-08 14:58:12,195 DEBUG : BROWSER_OUTPUT: 14:58:14 INFO - 2015-12-08 14:58:14,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44424/tests/kraken/driver.html?testName=audio-dft) 14:58:15 INFO - 2015-12-08 14:58:15,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 141676544 14:58:15 INFO - 2015-12-08 14:58:15,580 DEBUG : BROWSER_OUTPUT: 14:58:18 INFO - 2015-12-08 14:58:18,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44424/tests/kraken/driver.html?testName=audio-fft) 14:58:19 INFO - 2015-12-08 14:58:19,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 138461184 14:58:19 INFO - 2015-12-08 14:58:19,081 DEBUG : BROWSER_OUTPUT: 14:58:21 INFO - 2015-12-08 14:58:21,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44424/tests/kraken/driver.html?testName=audio-oscillator) 14:58:21 INFO - 2015-12-08 14:58:21,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 139608064 14:58:21 INFO - 2015-12-08 14:58:21,785 DEBUG : BROWSER_OUTPUT: 14:58:24 INFO - 2015-12-08 14:58:24,067 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44424/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:58:24 INFO - 2015-12-08 14:58:24,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 140808192 14:58:24 INFO - 2015-12-08 14:58:24,669 DEBUG : BROWSER_OUTPUT: 14:58:27 INFO - 2015-12-08 14:58:27,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44424/tests/kraken/driver.html?testName=imaging-darkroom) 14:58:28 INFO - 2015-12-08 14:58:28,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 139911168 14:58:28 INFO - 2015-12-08 14:58:28,289 DEBUG : BROWSER_OUTPUT: 14:58:31 INFO - 2015-12-08 14:58:31,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44424/tests/kraken/driver.html?testName=imaging-desaturate) 14:58:32 INFO - 2015-12-08 14:58:32,357 DEBUG : BROWSER_OUTPUT: RSS: Main: 138285056 14:58:32 INFO - 2015-12-08 14:58:32,357 DEBUG : BROWSER_OUTPUT: 14:58:35 INFO - 2015-12-08 14:58:35,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44424/tests/kraken/driver.html?testName=json-parse-financial) 14:58:35 INFO - 2015-12-08 14:58:35,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 138231808 14:58:35 INFO - 2015-12-08 14:58:35,823 DEBUG : BROWSER_OUTPUT: 14:58:37 INFO - 2015-12-08 14:58:37,613 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44424/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:58:38 INFO - 2015-12-08 14:58:38,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 140673024 14:58:38 INFO - 2015-12-08 14:58:38,199 DEBUG : BROWSER_OUTPUT: 14:58:40 INFO - 2015-12-08 14:58:40,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44424/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:58:40 INFO - 2015-12-08 14:58:40,696 DEBUG : BROWSER_OUTPUT: RSS: Main: 141611008 14:58:40 INFO - 2015-12-08 14:58:40,697 DEBUG : BROWSER_OUTPUT: 14:58:42 INFO - 2015-12-08 14:58:42,922 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44424/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:58:43 INFO - 2015-12-08 14:58:43,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 141320192 14:58:43 INFO - 2015-12-08 14:58:43,511 DEBUG : BROWSER_OUTPUT: 14:58:46 INFO - 2015-12-08 14:58:46,128 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:58:46 INFO - 2015-12-08 14:58:46,735 DEBUG : BROWSER_OUTPUT: RSS: Main: 141463552 14:58:46 INFO - 2015-12-08 14:58:46,735 DEBUG : BROWSER_OUTPUT: 14:58:49 INFO - 2015-12-08 14:58:49,351 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:58:49 INFO - 2015-12-08 14:58:49,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 141008896 14:58:49 INFO - 2015-12-08 14:58:49,953 DEBUG : BROWSER_OUTPUT: 14:58:51 INFO - 2015-12-08 14:58:51,743 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44424/tests/kraken/driver.html?testName=ai-astar) 14:58:51 INFO - 2015-12-08 14:58:51,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 141049856 14:58:51 INFO - 2015-12-08 14:58:51,989 DEBUG : BROWSER_OUTPUT: 14:58:51 INFO - 2015-12-08 14:58:51,991 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:58:51 INFO - 2015-12-08 14:58:51,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:58:51 INFO - 2015-12-08 14:58:51,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:58:51 INFO - 2015-12-08 14:58:51,991 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:58:51 INFO - 2015-12-08 14:58:51,991 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;110;114;114;115;125;114;115;116;114 14:58:51 INFO - 2015-12-08 14:58:51,991 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;135;160;168;134;153;163;133;173;131 14:58:51 INFO - 2015-12-08 14:58:51,991 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;163;163;162;165;172;163;164;164;166 14:58:51 INFO - 2015-12-08 14:58:51,992 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;75;130;73;78;73;75;93 14:58:51 INFO - 2015-12-08 14:58:51,992 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;128;95;95;94;146;95;96;136 14:58:51 INFO - 2015-12-08 14:58:51,992 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;110;110 14:58:51 INFO - 2015-12-08 14:58:51,992 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;149;147;149;148;148;147;154;149;147 14:58:51 INFO - 2015-12-08 14:58:51,992 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;95;97;96;96;96;97;96;96 14:58:51 INFO - 2015-12-08 14:58:51,992 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;76;75;75;76;75;75;75;75;75 14:58:51 INFO - 2015-12-08 14:58:51,992 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;69;70;70;70;70;69;70;70;70 14:58:51 INFO - 2015-12-08 14:58:51,992 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;84;88;85;87;84;84;85;95;101 14:58:51 INFO - 2015-12-08 14:58:51,993 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;137;124;121;122;125;135;138;120;129;130 14:58:51 INFO - 2015-12-08 14:58:51,993 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;140;148;155;145;148;133;155;147;147;136 14:58:51 INFO - 2015-12-08 14:58:51,993 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;70;71;71;71;71;70;69;72 14:58:51 INFO - 2015-12-08 14:58:51,993 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:58:51 INFO - 2015-12-08 14:58:51,993 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:58:51 INFO - 2015-12-08 14:58:51,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,804 14:58:51 INFO - 2015-12-08 14:58:51,993 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:58:51 INFO - 2015-12-08 14:58:51,994 DEBUG : BROWSER_OUTPUT: __startTimestamp1449615531990__endTimestamp 14:58:51 INFO - 2015-12-08 14:58:51,994 DEBUG : BROWSER_OUTPUT: 14:58:51 INFO - 2015-12-08 14:58:51,997 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:58:51 INFO - 2015-12-08 14:58:51,997 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:58:51 INFO - 2015-12-08 14:58:51,997 DEBUG : BROWSER_OUTPUT: 14:58:51 INFO - 2015-12-08 14:58:51,997 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.10 Median:114.50 stddev:3.81 (3.3%) stddev-sans-first:4.02 14:58:51 INFO - 2015-12-08 14:58:51,997 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 114.0 114.0 115.0 125.0 114.0 115.0 116.0 114.0 14:58:51 INFO - 2015-12-08 14:58:51,997 DEBUG : BROWSER_OUTPUT: 14:58:51 INFO - 2015-12-08 14:58:51,998 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.70 Median:158.50 stddev:16.01 (10.1%) stddev-sans-first:16.82 14:58:51 INFO - 2015-12-08 14:58:51,998 DEBUG : BROWSER_OUTPUT: Values: 157.0 135.0 160.0 168.0 134.0 153.0 163.0 133.0 173.0 131.0 14:58:51 INFO - 2015-12-08 14:58:51,998 DEBUG : BROWSER_OUTPUT: 14:58:51 INFO - 2015-12-08 14:58:51,998 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:3.06 (1.9%) stddev-sans-first:3.00 14:58:51 INFO - 2015-12-08 14:58:51,998 DEBUG : BROWSER_OUTPUT: Values: 161.0 163.0 163.0 162.0 165.0 172.0 163.0 164.0 164.0 166.0 14:58:51 INFO - 2015-12-08 14:58:51,998 DEBUG : BROWSER_OUTPUT: 14:58:51 INFO - 2015-12-08 14:58:51,998 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:74.00 stddev:18.25 (24.7%) stddev-sans-first:19.04 14:58:52 INFO - 2015-12-08 14:58:51,998 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 75.0 130.0 73.0 78.0 73.0 75.0 93.0 14:58:52 INFO - 2015-12-08 14:58:51,998 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:51,999 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.50 stddev:20.72 (21.9%) stddev-sans-first:21.41 14:58:52 INFO - 2015-12-08 14:58:51,999 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 128.0 95.0 95.0 94.0 146.0 95.0 96.0 136.0 14:58:52 INFO - 2015-12-08 14:58:51,999 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:51,999 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:58:52 INFO - 2015-12-08 14:58:51,999 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 14:58:52 INFO - 2015-12-08 14:58:51,999 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:51,999 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:2.07 (1.4%) stddev-sans-first:2.18 14:58:52 INFO - 2015-12-08 14:58:51,999 DEBUG : BROWSER_OUTPUT: Values: 148.0 149.0 147.0 149.0 148.0 148.0 147.0 154.0 149.0 147.0 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 95.0 97.0 96.0 96.0 96.0 97.0 96.0 96.0 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.20 Median:75.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: Values: 75.0 76.0 75.0 75.0 76.0 75.0 75.0 75.0 75.0 75.0 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 70.0 70.0 70.0 70.0 69.0 70.0 70.0 70.0 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:52,000 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.00 stddev:5.71 (6.7%) stddev-sans-first:5.97 14:58:52 INFO - 2015-12-08 14:58:52,001 DEBUG : BROWSER_OUTPUT: Values: 85.0 84.0 88.0 85.0 87.0 84.0 84.0 85.0 95.0 101.0 14:58:52 INFO - 2015-12-08 14:58:52,001 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:52,001 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:129.50 stddev:6.74 (5.2%) stddev-sans-first:6.33 14:58:52 INFO - 2015-12-08 14:58:52,001 DEBUG : BROWSER_OUTPUT: Values: 137.0 124.0 121.0 122.0 125.0 135.0 138.0 120.0 129.0 130.0 14:58:52 INFO - 2015-12-08 14:58:52,001 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:52,001 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:147.50 stddev:7.26 (4.9%) stddev-sans-first:7.43 14:58:52 INFO - 2015-12-08 14:58:52,002 DEBUG : BROWSER_OUTPUT: Values: 140.0 148.0 155.0 145.0 148.0 133.0 155.0 147.0 147.0 136.0 14:58:52 INFO - 2015-12-08 14:58:52,002 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:52,002 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 14:58:52 INFO - 2015-12-08 14:58:52,002 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 71.0 71.0 71.0 71.0 70.0 69.0 72.0 14:58:52 INFO - 2015-12-08 14:58:52,002 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:58:52 INFO - 2015-12-08 14:58:52,002 DEBUG : BROWSER_OUTPUT: 14:58:52 INFO - 2015-12-08 14:58:52,939 INFO : Browser exited with error code: 0 14:58:52 INFO - 2015-12-08 14:58:52,992 INFO : Completed test kraken (00:01:01) 14:58:52 INFO - 2015-12-08 14:58:52,992 INFO : Starting test v8_7 14:58:52 INFO - 2015-12-08 14:58:52,993 DEBUG : operating with platform_type : linux_ 14:58:52 INFO - 2015-12-08 14:58:52,993 INFO : Initialising browser for v8_7 test... 14:58:52 INFO - 2015-12-08 14:58:52,999 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWV0xU3/profile http://localhost:44424/getInfo.html 14:58:57 INFO - 2015-12-08 14:58:57,352 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:58:57 INFO - 2015-12-08 14:58:57,352 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:58:57 INFO - 2015-12-08 14:58:57,352 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:58:57 INFO - 2015-12-08 14:58:57,352 DEBUG : BROWSER_OUTPUT: __metrics 14:58:57 INFO - 2015-12-08 14:58:57,460 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] 14:58:58 INFO - 2015-12-08 14:58:58,363 INFO : Browser initialized. 14:58:58 INFO - 2015-12-08 14:58:58,364 INFO : Running cycle 1/1 for v8_7 test... 14:58:58 INFO - 2015-12-08 14:58:58,364 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWV0xU3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:59:10 INFO - 2015-12-08 14:59:10,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 143278080 14:59:10 INFO - 2015-12-08 14:59:10,451 DEBUG : BROWSER_OUTPUT: 14:59:31 INFO - 2015-12-08 14:59:31,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44424/tests/v8_7/run.html (next: http://localhost:44424/tests/v8_7/run.html) 14:59:32 INFO - 2015-12-08 14:59:32,190 DEBUG : BROWSER_OUTPUT: RSS: Main: 138727424 14:59:32 INFO - 2015-12-08 14:59:32,190 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: |0;Richards;167.3080140538732 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.25379770285292 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1078.6637931034484 14:59:32 INFO - 2015-12-08 14:59:32,191 DEBUG : BROWSER_OUTPUT: |5;Earley;727.802037845706 14:59:32 INFO - 2015-12-08 14:59:32,192 DEBUG : BROWSER_OUTPUT: |6;Boyer;12419.753086419752 14:59:32 INFO - 2015-12-08 14:59:32,192 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 14:59:32 INFO - 2015-12-08 14:59:32,192 DEBUG : BROWSER_OUTPUT: |8;Splay;597.6331360946746 14:59:32 INFO - 2015-12-08 14:59:32,192 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 14:59:32 INFO - 2015-12-08 14:59:32,192 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:59:32 INFO - 2015-12-08 14:59:32,192 DEBUG : BROWSER_OUTPUT: __startTimestamp1449615572184__endTimestamp 14:59:32 INFO - 2015-12-08 14:59:32,192 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,192 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:59:32 INFO - 2015-12-08 14:59:32,193 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:59:32 INFO - 2015-12-08 14:59:32,193 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,193 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.31 Median:167.31 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,193 DEBUG : BROWSER_OUTPUT: Values: 167.3 14:59:32 INFO - 2015-12-08 14:59:32,193 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,193 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.25 Median:185.25 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,193 DEBUG : BROWSER_OUTPUT: Values: 185.3 14:59:32 INFO - 2015-12-08 14:59:32,194 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,194 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,194 DEBUG : BROWSER_OUTPUT: Values: 278.0 14:59:32 INFO - 2015-12-08 14:59:32,194 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,194 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,194 DEBUG : BROWSER_OUTPUT: Values: 5218.8 14:59:32 INFO - 2015-12-08 14:59:32,194 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,194 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1078.66 Median:1078.66 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,195 DEBUG : BROWSER_OUTPUT: Values: 1078.7 14:59:32 INFO - 2015-12-08 14:59:32,195 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,195 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:727.80 Median:727.80 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,195 DEBUG : BROWSER_OUTPUT: Values: 727.8 14:59:32 INFO - 2015-12-08 14:59:32,195 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,195 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,195 DEBUG : BROWSER_OUTPUT: Values: 12419.8 14:59:32 INFO - 2015-12-08 14:59:32,196 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,196 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,196 DEBUG : BROWSER_OUTPUT: Values: 26394.7 14:59:32 INFO - 2015-12-08 14:59:32,196 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,196 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.63 Median:597.63 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,196 DEBUG : BROWSER_OUTPUT: Values: 597.6 14:59:32 INFO - 2015-12-08 14:59:32,196 DEBUG : BROWSER_OUTPUT: 14:59:32 INFO - 2015-12-08 14:59:32,196 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 14:59:32 INFO - 2015-12-08 14:59:32,197 DEBUG : BROWSER_OUTPUT: Values: 4835.7 14:59:32 INFO - 2015-12-08 14:59:32,197 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:59:32 INFO - 2015-12-08 14:59:32,197 DEBUG : BROWSER_OUTPUT: 14:59:33 INFO - 2015-12-08 14:59:33,103 INFO : Browser exited with error code: 0 14:59:33 INFO - 2015-12-08 14:59:33,117 INFO : Completed test v8_7 (00:00:40) 14:59:33 INFO - 2015-12-08 14:59:33,198 INFO : Completed test suite (00:20:15) 14:59:33 INFO - 2015-12-08 14:59:33,199 DEBUG : Working with test: dromaeo_css 14:59:33 INFO - 2015-12-08 14:59:33,199 DEBUG : Generating results file: dromaeo_css 14:59:33 INFO - 2015-12-08 14:59:33,200 DEBUG : Working with test: kraken 14:59:33 INFO - 2015-12-08 14:59:33,200 DEBUG : Generating results file: kraken 14:59:33 INFO - 2015-12-08 14:59:33,200 INFO : javascript benchmark 14:59:33 INFO - 2015-12-08 14:59:33,201 DEBUG : Working with test: v8_7 14:59:33 INFO - 2015-12-08 14:59:33,201 DEBUG : Generating results file: v8_7 14:59:33 INFO - 2015-12-08 14:59:33,201 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:59:33 INFO - 2015-12-08 14:59:33,250 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 14:59:33 INFO - 2015-12-08 14:59:33,250 DEBUG : process_Request line: dromaeo_css 6206.96 graph.html#tests=[[72,94,43]] 14:59:33 INFO - 2015-12-08 14:59:33,250 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:59:33 INFO - 2015-12-08 14:59:33,277 DEBUG : process_Request line: kraken 1550.30 graph.html#tests=[[232,94,43]] 14:59:33 INFO - 2015-12-08 14:59:33,277 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:59:33 INFO - 2015-12-08 14:59:33,304 DEBUG : process_Request line: v8_7 21236.53 graph.html#tests=[[230,94,43]] 14:59:33 INFO - 2015-12-08 14:59:33,305 INFO : javascript benchmark 14:59:33 INFO - 2015-12-08 14:59:33,309 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2673.8796754146065, 2698.9865050674766, 2742.2458823823445, 2748.40909204521, 2758.3242105684103, 4569.428821397325, 4712.646551508634, 4788.0, 4794.47260801312, 4850.660453768238, 4663.790129444174, 4678.041001594674, 4679.906401871969, 4712.552307530787, 4891.804327826882, 4247.15056988602, 4346.15250026245, 4397.186520493703, 4403.141387429452, 4434.201843668138, 245.30276208564322, 4348.97825510872, 4447.221736196153, 4448.666350023745, 4459.219636563605, 4186.267403204442, 4289.2922667759785, 4348.543402942709, 4371.082072764723, 4450.888727781799, 4375.7593332366705, 4384.430024096847, 4414.977925110386, 4415.425994620711, 4442.755648439334, 4120.320147175712, 4368.890777730582, 4370.562943705636, 4370.694051416371, 4436.201483732927, 4589.655775816827, 4706.317583950308, 4770.284457331393, 4770.76146192689, 4792.496787837296, 5121.692698438105, 5135.4094279158, 5137.101007323703, 5139.306193663845, 5140.871478213075, 4892.63305252104, 5010.674306170087, 5141.408737995141, 5161.509656582619, 5167.224916262553, 4704.364910737041, 4784.6889952153, 4786.5452781986005, 4800.495947925488, 4833.637477189225, 5270.420253772082, 5282.762275697526, 5289.867753306121, 5291.417944026154, 5308.867278318073, 4911.091448082117, 5027.622928280393, 5050.924236136461, 5090.541851233407, 5091.032703786269, 4993.425756038029, 5046.243063540425, 5057.772400241998, 5077.289179514871, 5108.080545501845, 5084.8220312288895, 5111.437741848394, 5137.614678899097, 5148.30497882781, 5192.9614077184715, 4648.651351148677, 4788.784504697297, 4953.925691114636, 5114.616403769658, 5115.590752739772, 4218.261804184317, 4233.259179643612, 4252.702310838212, 4278.529361770203, 4279.443672322578, 3716.1452865841006, 3717.6096509866074, 3728.179800443898, 3732.3654978653153, 3742.476053352478, 4209.536950935395, 4270.7010509264055, 4339.522652508222, 4383.978080109579, 4398.186335527937, 5131.435542090367, 5138.58891288696, 5143.12566863634, 5145.76844042019, 5165.251038599382, 4343.305071188594, 4370.8033138508845, 4382.123575284892, 4389.297712366006, 4402.713823601455, 4311.159323931804, 4408.4930233023615, 4460.977695111568, 4546.818127274872, 4584.106099310669, 4723.055388922161, 4734.21885388907, 4746.288056791509, 4757.762111894392, 4767.904641907143, 4954.5540901319055, 5074.67014644047, 5075.822346217865, 5081.441041485507, 5126.56424203932, 4683.976580117078, 4734.455537613218, 4749.026449577759, 4760.6429517787, 4794.880127996828, 5002.949970500394, 5037.0681423936685, 5072.188449848007, 5074.340335756476, 5116.897662046813, 4908.141075311878, 5057.924131137962, 5109.718965456936, 5160.793568257228, 5204.37547494288, 4867.318575399518, 4924.803007879788, 4938.789996450892, 4949.653524253267, 4975.626827987988, 4950.059488697136, 4992.201247800334, 5006.749662516932, 5006.774695138654, 5008.69947803133, 4738.97630511859, 4832.371791667061, 4839.225723884302, 4899.681520701143, 4957.652964292609, 4941.925871112008, 4961.0, 4963.230699241623, 4974.427940786856, 5017.498250174954, 4781.330613714153, 4846.80612775485, 4857.562819346276, 4866.343043689057, 4926.3842019747535], "unit": "ms", "name": "dojo.html", "value": 4630.526350186448}, {"lowerIsBetter": false, "replicates": [511.2969666708278, 539.9271098401715, 540.9242706021156, 550.3698265486018, 551.3549147497428, 26464.73535264649, 27042.459150816972, 34894.651053489455, 35391.469127963035, 35420.11449713758, 39178.0, 39506.60493395065, 39574.20851582967, 39631.405528917014, 39650.40524392129, 7949.165337639552, 8125.593720313961, 8134.186581341878, 8145.674173033071, 8161.143079976606, 7875.212478752136, 7987.281144696976, 7987.440879138463, 7993.200679932019, 8001.159878212791, 7999.160088190743, 8023.638936247854, 8099.190080991883, 8105.554194519299, 8105.75682729519, 7964.8805267921025, 7977.760667179994, 8020.0, 8033.357331413473, 8058.11360750317, 7855.489393189481, 7903.36773058154, 7910.4462687611895, 7963.641636126388, 7999.240072193133, 36127.81936090329, 36539.63460365389, 36601.0, 36770.63229367699, 36773.81613091944, 2779.596958441035, 2883.5818806273182, 3102.6276846778305, 3423.8288085595623, 3444.0, 27828.165155045383, 27836.582451263246, 27850.5822412664, 27932.58101128485, 28033.57949630757, 3354.4465163248033, 3411.7441191910457, 3431.8815235804996, 3473.513708080871, 3546.2198316370614, 212841.0, 213417.0, 213581.0, 214626.0, 214628.0, 46486.5351346489, 48041.0, 56473.71763141158, 57819.0, 57862.0, 48739.756301218265, 48969.75515122473, 49123.0, 49158.26262606064, 49192.0, 12716.491340346283, 12756.617301480785, 12773.936130319289, 12848.0, 12873.163244389272, 9399.483028433366, 9445.480498572644, 9461.574229159703, 9463.148316651534, 9469.337146399823, 18599.25602975893, 18897.33859314945, 18953.620927581647, 19027.429177124708, 19035.1434185462, 7172.748953786592, 7360.374368178765, 7416.22129676387, 7419.0, 7459.291367320096, 784.6759735196663, 798.5647821937058, 854.7435769269194, 890.2210565754964, 933.8132373525322, 24867.875660621943, 26066.609000865003, 26329.868350658126, 27181.0, 27385.726142738316, 887.4364778365655, 923.8383282925461, 940.7365937537501, 946.3895787217207, 1030.5465595138114, 11602.883971160349, 11645.12661550387, 11792.0, 12154.209976351509, 12368.44342004612, 247975.0, 248539.0, 248666.0, 250727.98544029018, 251293.0, 44834.32748508775, 45119.0, 45338.773306133255, 45358.0, 45398.319025214645, 1223.804191329383, 1225.66906935127, 1226.4235809169677, 1251.355551890777, 1254.9749005019848, 21778.12887484546, 22023.0, 22088.77911220867, 22265.109395623993, 23158.305250842503, 37730.24539509249, 38304.616953830104, 38382.42426363551, 38512.22975540417, 38643.42034869423, 237852.0, 240112.0, 240967.0, 241396.0, 242423.51517697502, 28399.0, 28608.0, 29209.415811684074, 29241.561376579793, 29352.853235733684, 34756.65243347534, 35001.824990874884, 37016.0, 37363.2527349446, 37547.436788448744, 31107.0, 31702.84148579242, 31949.840250799527, 32249.51625725663, 32432.189195270308, 28790.856045720477, 29080.418391631625, 31971.360572787948, 33722.49416258709, 33890.49164262489, 29694.703052969195, 29900.252493687833, 29955.70044299529, 30086.0, 30096.398072038875, 27393.452130957667, 29029.564556531248, 29293.560596591495, 29674.406511870075, 30685.693143068285, 21778.847113791664, 23346.416339590967, 23766.405839854142, 23908.282751517483, 23957.880210598836], "unit": "ms", "name": "ext.html", "value": 16219.487939891353}, {"lowerIsBetter": false, "replicates": [277.0, 281.1242978123146, 281.30237012209733, 283.16325258860064, 286.91105757215263, 13145.474181032747, 13298.601041968732, 14645.26773661318, 15075.698486030287, 15199.164045977466, 8594.312455003601, 8848.867266991001, 9449.196818270439, 9556.42661440314, 9670.032996700327, 4290.249206388878, 4366.323219900904, 4377.912441751163, 4382.517923028464, 4386.868393948187, 3496.9300613987707, 3609.169890925089, 4399.296112621981, 4808.447028591704, 4991.376077990251, 4954.554090131887, 4973.204287314031, 4974.950250497485, 4991.450940396553, 4993.201087825949, 4893.535114164149, 4931.3835770528685, 5709.486146246837, 5721.513671337942, 5725.3988331225455, 5041.747912604355, 5054.646174767768, 5056.115179843513, 5060.51925067118, 5060.645754797166, 10982.505787239514, 10989.06592939601, 11001.22991390603, 11168.218224724273, 15024.624384390369, 1766.143420441085, 1831.2034265094726, 1835.2750663487982, 1920.5198700324918, 2005.177877070394, 8789.824203515958, 8805.16350946659, 9651.71044868655, 9807.90192098077, 12858.164219325807, 1656.5941344370585, 1668.1742537443922, 1674.5897255172438, 1692.069361850977, 1707.7779888614525, 51015.0, 51486.0, 51569.74215128938, 52785.0, 59007.81984360332, 9399.953000234955, 9589.376690515093, 9726.75683107928, 9727.319087663936, 9739.464329461805, 11859.288442693465, 11913.0, 11934.582289619822, 11934.701632459259, 12022.939885300517, 7115.217326094125, 7139.143302803697, 7156.642167891585, 7163.462740294499, 7208.207097219301, 6716.46268298535, 6725.260221375743, 6746.325367463312, 6754.527183097136, 6787.0, 4015.6185162409524, 4068.2066996935314, 4081.836726530965, 4108.835646574164, 4137.855175068858, 1676.7652528645756, 1696.5334533003522, 1719.9914000429917, 1737.4189487566255, 1746.275295752274, 726.5894769455241, 757.2957149850691, 825.3520986025941, 838.9973981092536, 956.7560272130562, 13690.52083177084, 14246.358913848902, 14353.784693229401, 14536.491222807152, 14615.488457904135, 831.0899564976341, 848.3637272045966, 857.8455877942031, 887.9156480134377, 939.492673956056, 8200.835983280302, 9243.121903419164, 9243.953780231055, 9288.34981551285, 9407.858882116774, 476772.0, 481807.0, 484498.0, 492935.0, 494488.0, 70985.0, 73804.0, 73877.0, 74864.0, 76299.0, 1025.8102251083574, 1057.4131357096885, 1062.8937106289463, 1065.1798115451058, 1069.0, 14838.40646374133, 14890.627734306729, 14906.925465372604, 15023.549293521211, 15418.30617622232, 33428.0, 33753.32493350168, 33861.49207761935, 34558.654413455544, 34720.0, 43763.78118109389, 45389.0, 45978.31032534448, 46922.53077469182, 47406.52593474021, 8206.179382061746, 8287.751367458986, 8312.625931833203, 8375.832483350421, 8377.70678026266, 9831.803363932539, 9906.851397228904, 14313.427462901784, 14390.928045359706, 15133.470328538448, 12883.291418972047, 12904.8064279034, 12958.092933494565, 13150.07949443568, 13332.666683332995, 12433.440495177558, 12652.304123273309, 12794.360281985677, 12916.677083072622, 13033.674158146123, 12707.491700331882, 12931.741365172831, 13020.674483137997, 13207.60377188686, 13306.0, 8287.544185069879, 8292.502449853027, 8410.369222308229, 8465.449745766506, 8513.148685131686, 8758.912410876064, 8850.867236991578, 12813.423395947018, 13534.59396218115, 13994.65013374633], "unit": "ms", "name": "jquery.html", "value": 7805.625133793893}, {"lowerIsBetter": false, "replicates": [1469.9930547574918, 1657.2542355939827, 1717.450415866923, 1718.458685514063, 1747.4058820001196, 5875.324337701166, 6049.697515124249, 7182.748603798868, 7462.999999999994, 7468.103827540696, 6866.416354609852, 7134.0369050178215, 7170.498065135443, 7198.712051517933, 7266.96366518168, 2012.7987201279902, 2022.8280596149345, 2028.8782673039666, 2041.061111888533, 2046.3451695457459, 1995.3215906591756, 2000.30989308689, 2007.5282308657454, 2052.302217246136, 2054.979450205494, 1975.4073777866654, 2011.788762179972, 2039.20471016303, 2040.7040979058027, 2043.795620437959, 2041.8876961767096, 2063.030375723408, 2064.783197764228, 2072.8445366597566, 2082.4585607741947, 2003.91984320627, 2009.4976255936017, 2018.6669199582052, 2039.520712632545, 2077.1898959405844, 7119.53723008008, 7169.533980291264, 7179.210286868441, 7189.532680375811, 7200.963995180043, 4060.898477538085, 4100.17996400721, 4109.404136400205, 4110.424540564323, 4117.464729585165, 2671.051776619311, 2678.464307138561, 2696.730326967307, 2750.2024412920227, 2750.4636595863813, 770.8728059870115, 772.3898120484811, 773.9419543534258, 805.2189376304975, 831.6257684042145, 9390.85913711295, 9465.66870159541, 9480.668176613854, 9488.28837837165, 9498.620055197714, 3727.1986522897705, 3732.776033437948, 3766.0208345830283, 3780.1683629601443, 3790.639889210521, 8196.672133114727, 8204.753857384288, 8209.58952052395, 8216.917830821734, 8259.0, 4062.0, 4071.185762847383, 4073.5926407359025, 4082.6937979651643, 4084.8366065357645, 3158.699923507263, 3245.496947973068, 3694.3350196964802, 3702.1670124221832, 3709.8330575123646, 3343.4984752286864, 3369.814660193713, 3372.8144952027874, 3401.4217583010945, 3434.587849458031, 1039.953202105907, 1043.6555936540924, 1046.727850758793, 1050.4537640426936, 1050.4590136079926, 984.5077461269366, 1023.2888142740724, 1027.5786927359895, 1028.2082796246848, 1057.8413238014205, 6596.4393026592315, 6629.303923088103, 6631.602103873783, 6658.86682266352, 6669.533132680665, 392.6466180437629, 397.191714860258, 1072.9068603278624, 1122.1920217443428, 1125.5497800879714, 5207.843764687065, 5229.633925625246, 5242.161254199386, 5430.8913821723345, 5622.662640241599, 8153.0, 8253.0, 8273.627686754111, 8278.0, 8296.875546866802, 8206.261436470746, 8216.21945915137, 8224.506529608243, 8230.588470576447, 8536.061033286334, 6690.397864192246, 6712.362325579063, 6743.190817101881, 6774.220964589135, 6794.592324460548, 6543.247526534319, 6653.866922661423, 6665.266820649822, 6692.230393504809, 6727.663616819042, 7269.200387957426, 7768.88346674789, 7774.067111946602, 7784.532928024337, 7836.09884863248, 7682.8079298018, 7736.92263077362, 7796.610169491616, 7810.336121429515, 7901.644426000728, 5676.2337084493065, 5939.316978547522, 6011.977963746086, 6319.873602528016, 6370.108184854032, 6538.1500404947055, 6539.346065393423, 6545.5090868184125, 6547.836304092436, 6564.376384243489, 6107.0, 6282.8429289266305, 6284.24589049317, 6322.494200464043, 6393.29673735898, 6215.81352559424, 6246.219222597176, 6259.2488901332135, 6334.619922804646, 6351.841203969938, 6150.954337762501, 6192.81421557354, 6196.721147548281, 6212.751489940351, 6214.067889816563, 5857.092150716646, 5868.794592189253, 5879.412058794086, 5886.20536227621, 5890.793822216202, 5707.971460142673, 5776.624519406225, 5795.304563452412, 5815.33123690764, 5816.5055970243], "unit": "ms", "name": "mootools.html", "value": 4000.30583623192}, {"lowerIsBetter": false, "replicates": [246.83092081923883, 255.04231610303302, 256.6650521070004, 257.0975874679873, 261.2997167590856, 5495.395506494292, 5598.068666310127, 5651.660900345983, 5659.122835960433, 5691.0, 5432.75552600133, 5583.302087239095, 5586.720663966806, 5597.888042239153, 5612.943870561293, 4157.147784704143, 4177.456930599025, 4182.2890108681595, 4188.916221675565, 4189.455370801791, 4155.210510003105, 4160.791960401983, 4161.791910404483, 4185.225733239346, 4189.664826813848, 3969.4839670842894, 4074.3684728867074, 4131.958680413202, 4140.0, 4140.378943158536, 4031.1937612477623, 4044.5348784889675, 4050.9137794036096, 4097.692673049503, 4104.548499665035, 3484.790912545255, 3488.284901595167, 3490.8603655853735, 3491.0, 3508.28080243552, 5378.569714422837, 5385.434529374437, 5386.973065134688, 5389.353277606673, 5410.08028635133, 4487.282034874404, 4704.411948506437, 4718.693284936502, 4723.173444647173, 4733.5976442002475, 5715.457031581993, 5833.387494313079, 5846.269216347957, 5854.76580936762, 5864.501517371029, 3787.9810600947094, 3796.9810150949343, 3797.6012518685693, 3797.6202379761803, 3800.524934383202, 6121.938780612226, 6160.6611636359985, 6198.690065496708, 6210.192674952273, 6218.844528886814, 3767.9449754068905, 3801.334766415866, 3807.276617442677, 3811.0662887592716, 3883.5922228165637, 3944.3491823848744, 3955.3869150281175, 3957.584453632385, 3958.604139586076, 3977.7812220327583, 4680.461746899082, 4685.484596694361, 4687.250039993584, 4690.81236750533, 4698.765061746967, 5893.11603259506, 5899.144624029492, 5906.675132867734, 5908.113782932594, 5925.081612350093, 1353.9932300338633, 1381.0884816021378, 1385.8752712255946, 1386.3207028556137, 1387.4172847404116, 878.872563478292, 886.4902680958475, 896.4845214001975, 900.8153328567628, 916.1662886773005, 5064.721440320818, 5070.797168113234, 5084.923726144111, 5089.338386009795, 5106.4893510648635, 6064.120702498113, 6068.666223357758, 6074.939250607437, 6079.635221886701, 6094.299155597163, 5021.648484606116, 5071.949280507221, 5071.974640126849, 5076.771545280471, 5077.974610126926, 3222.9033129006166, 3243.6756324367375, 3286.2441638423297, 3299.0762586475826, 3312.420326442863, 5791.768329266866, 5794.594378393556, 5797.91303130445, 5805.82582522525, 5813.09896965971, 6332.715027823667, 6386.808395748135, 6391.073294372383, 6397.96801015992, 6419.967900160469, 5610.298712660918, 5711.9714401428555, 5750.568707346965, 5765.0, 5777.364489906191, 6181.84545386369, 6186.1339412483185, 6196.938030619816, 6200.441960223421, 6209.0996805462055, 6076.088586712029, 6081.118237855575, 6084.026555751058, 6093.238345206849, 6100.0, 5760.193572899713, 5768.596198266249, 5770.740316685676, 5773.913391299218, 5783.942160578508, 3811.294910441577, 3900.4929359183125, 3929.685625149924, 3934.11482416454, 3959.564447910785, 6082.665453400105, 6119.2350956130485, 6151.477124444473, 6154.046122850787, 6160.599561028519, 5894.587378883437, 5900.793472228452, 5905.0, 5906.468417842415, 5906.70466476683, 5808.215890854681, 5904.822855314347, 5905.734241959208, 5967.76128954837, 5985.940140598538, 5783.971080144573, 5803.854903627274, 5819.621724587888, 5827.912581311199, 5842.357340692435, 5994.400559943971, 5997.790077347272, 6005.249343832021, 6009.158717779602, 6009.308929473166, 5747.655140691572, 5820.476157145878, 5845.035569131046, 5854.443827836349, 5876.08920617305], "unit": "ms", "name": "prototype.html", "value": 4288.648891141643}, {"lowerIsBetter": false, "replicates": [658.9802305930821, 676.7766637009787, 682.8019874236471, 708.6492186367749, 722.8554289142166, 11313.472681188037, 11355.148363872711, 11388.54445822166, 11524.078073754112, 11553.884461155396, 11353.091752659788, 11445.542178312879, 11480.196386252966, 13652.180869147858, 13958.302084895766, 788.357488646754, 796.3947399976031, 802.4783890471182, 809.017044291186, 812.2689579378548, 798.0383637716567, 800.7277525641281, 805.5770720371793, 805.605253425823, 805.9677612895478, 837.2632083766277, 843.4053991935671, 844.2022288936957, 844.3414136973171, 846.4878748357216, 835.5822088955522, 836.4354061008825, 837.0499483086679, 837.8031162676766, 841.9031811341682, 622.0141076393921, 622.6668732228281, 623.323693792236, 624.665803794972, 625.1622825413922, 11313.15151363651, 11372.090232781358, 11389.088872890148, 11389.202755807097, 11446.484908179153, 10478.528466219039, 10688.358698478116, 10988.285761425483, 11016.669499915015, 11254.324740515513, 9080.500572468512, 9105.63577456901, 9132.36073474857, 9258.72223833286, 9378.202852757524, 3212.229065024401, 3266.3630592034565, 3266.4610339293986, 3271.1167984644253, 3271.247613048988, 40053.39919901204, 40434.39348409776, 40596.188076238606, 40735.59264407348, 40868.59131408678, 8763.74756521263, 8936.8659470108, 8982.146696063994, 8986.910130898737, 9068.410553314014, 15686.215689215494, 15686.529404117895, 15705.842941570667, 15732.842671573138, 15756.212189390484, 5871.1486834409625, 6064.9090263646085, 6267.811965641038, 6451.483881289486, 6487.961926091897, 3440.776349537272, 3484.0767196692896, 3504.6144924058844, 3509.1051781795477, 3546.2730140321173, 2627.6846778386716, 2664.7335266473196, 2685.44948285601, 2694.474577457416, 2696.770774484191, 466.22606473254234, 475.0996860948552, 476.25941660717916, 477.21974571575726, 477.2411865134453, 418.36408658838394, 432.63658526837605, 533.8958903013875, 557.5483858074972, 571.5656101362994, 7349.595772232578, 7872.881906771288, 7907.169747176464, 7941.245581669732, 8044.597770111471, 466.6453495343495, 542.4548328929479, 604.7611193578512, 609.7713357490941, 611.9357467465941, 3624.5831729350934, 3702.8703995360033, 3763.2849758546336, 3782.6028267031566, 3801.2777572261184, 47390.76304618455, 52192.47807521952, 52211.0, 52536.211956820676, 52804.0, 42971.35542966858, 43164.13671726548, 43603.781981089895, 43641.56358436375, 44745.77627111909, 39903.60096399057, 40224.396634050514, 40480.39279410811, 40926.795366022976, 41436.79281603633, 7533.472656913963, 7776.533407995538, 7906.881396779168, 8090.959545202471, 8211.876821847558, 31057.844710776302, 31275.218119547193, 31551.84224078865, 31838.840805795822, 32064.679353207102, 35031.12422189466, 35093.64906350904, 35547.0, 38589.4211586832, 39877.0, 10394.792104158027, 10664.146868250677, 10844.0, 11165.106791456501, 11247.550097995989, 10633.149348051982, 10882.564697412015, 10939.726506837074, 11088.777052336656, 11439.59961401347, 10398.740031499274, 10789.082927951213, 10931.125509959344, 11029.0, 11117.388543630179, 10331.0, 10979.011888930034, 10984.450777461256, 11104.5558177672, 11132.666020019413, 10110.0, 10362.844557331797, 10571.04860562553, 10902.672919812418, 10940.39827809478, 9198.95400522993, 9446.717754135248, 9636.566354513923, 9640.132388085107, 9835.557399916877, 8680.609372578376, 8698.869516957377, 9305.720828375159, 9390.248780097712, 9446.38598491096], "unit": "ms", "name": "yui.html", "value": 5685.133199944665}], "name": "dromaeo_css", "value": 6206.956289356979}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 114.0, 114.0, 115.0, 125.0, 114.0, 115.0, 116.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [157.0, 135.0, 160.0, 168.0, 134.0, 153.0, 163.0, 133.0, 173.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 163.0, 162.0, 165.0, 172.0, 163.0, 164.0, 164.0, 166.0], "unit": "ms", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 75.0, 130.0, 73.0, 78.0, 73.0, 75.0, 93.0], "unit": "ms", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 128.0, 95.0, 95.0, 94.0, 146.0, 95.0, 96.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 149.0, 148.0, 148.0, 147.0, 154.0, 149.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 75.0, 75.0, 76.0, 75.0, 75.0, 75.0, 75.0, 75.0], "unit": "ms", "name": "json-parse-financial", "value": 75.2}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 70.0, 70.0, 70.0, 70.0, 69.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 88.0, 85.0, 87.0, 84.0, 84.0, 85.0, 95.0, 101.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 87.8}, {"lowerIsBetter": true, "replicates": [137.0, 124.0, 121.0, 122.0, 125.0, 135.0, 138.0, 120.0, 129.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 128.1}, {"lowerIsBetter": true, "replicates": [140.0, 148.0, 155.0, 145.0, 148.0, 133.0, 155.0, 147.0, 147.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 71.0, 71.0, 71.0, 71.0, 70.0, 69.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.5}], "name": "kraken", "value": 1550.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.3080140538732], "unit": "score", "name": "Richards", "value": 211.00005399999995}, {"lowerIsBetter": false, "replicates": [185.25379770285292], "unit": "score", "name": "DeltaBlue", "value": 356.90496399999995}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1078.6637931034484], "unit": "score", "name": "RayTrace", "value": 686.0237682317684}, {"lowerIsBetter": false, "replicates": [727.802037845706], "unit": "score", "name": "Earley", "value": 915.720162}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [597.6331360946746], "unit": "score", "name": "Splay", "value": 136.35622772277225}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21236.52793158743}]} 14:59:33 INFO - RETURN: dromaeo_css: 6206.96 14:59:33 INFO - RETURN: kraken: 1550.30 14:59:33 INFO - RETURN: v8_7: 21236.53 14:59:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21236.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1550.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6206.96"}}} 14:59:33 INFO - Return code: 0 14:59:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:59:33 INFO - # TBPL SUCCESS # 14:59:33 INFO - Running post-action listener: _resource_record_post_action 14:59:33 INFO - Running post-run listener: _resource_record_post_run 14:59:34 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 521265152; Read time: 0; Write time: 527088 14:59:34 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 232194048; Read time: 0; Write time: 368564 14:59:34 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 0; Write bytes: 273924096; Read time: 0; Write time: 150640 14:59:34 INFO - Running post-run listener: _upload_blobber_files 14:59:34 INFO - Blob upload gear active. 14:59:34 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:59:34 INFO - Copying logs to upload dir... 14:59:34 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.590349 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-08 14:59:33.304914) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 14:59:33.309051) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009886 build_url: 'https://queue.taskcluster.net/v1/task/qS-Lf4IQStqJ9IEDPT-N4Q/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-08 14:59:33.361217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 14:59:33.361612) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1449613911.30562-1039836286 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 14:59:33.414732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 14:59:33.415513) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 14:59:33.416203) ========= ========= Total master_lag: 5.67 =========