builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1461024393.06 results: success (0) buildid: 20160418164227 builduid: 82f2696efcfc4b4c9e980de264f9260b revision: 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:33.061559) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:33.062054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:33.062346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:33.296964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:33.297276) ========= 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=232498196343f89f466a4a9a000001c8-1461024090.849090-678595068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-18 17:06:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.8M=0s 2016-04-18 17:06:33 (89.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101945 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:33.412442) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:33.412747) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=232498196343f89f466a4a9a000001c8-1461024090.849090-678595068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021164 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:33.464546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 17:06:33.464865) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 --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=232498196343f89f466a4a9a000001c8-1461024090.849090-678595068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-18 17:06:34,028 truncating revision to first 12 chars 2016-04-18 17:06:34,029 Setting DEBUG logging. 2016-04-18 17:06:34,029 attempt 1/10 2016-04-18 17:06:34,029 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/05a9daa3368c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-18 17:06:34,915 unpacking tar archive at: fx-team-05a9daa3368c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.173039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-18 17:06:34.656146) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:34.656738) ========= script_repo_revision: 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:34.657517) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:34.658132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-18 17:06:34.669542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-18 17:06:34.669852) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1461024090.849090-678595068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:35 INFO - MultiFileLogger online at 20160418 17:06:35 in /builds/slave/test 17:06:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:06:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:06:35 INFO - {'append_to_log': False, 17:06:35 INFO - 'base_work_dir': '/builds/slave/test', 17:06:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:06:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:06:35 INFO - 'branch': 'Fx-Team-Non-PGO', 17:06:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:35 INFO - 'config_files': ('talos/linux_config.py',), 17:06:35 INFO - 'default_actions': ('clobber', 17:06:35 INFO - 'read-buildbot-config', 17:06:35 INFO - 'download-and-extract', 17:06:35 INFO - 'populate-webroot', 17:06:35 INFO - 'create-virtualenv', 17:06:35 INFO - 'install', 17:06:35 INFO - 'run-tests'), 17:06:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:35 INFO - 'download_minidump_stackwalk': True, 17:06:35 INFO - 'download_symbols': 'ondemand', 17:06:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:35 INFO - 'installer_path': 'installer.exe', 17:06:35 INFO - 'log_level': 'info', 17:06:35 INFO - 'log_name': 'talos', 17:06:35 INFO - 'log_to_console': True, 17:06:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:35 INFO - 'opt_config_files': (), 17:06:35 INFO - 'pip_index': False, 17:06:35 INFO - 'sps_profile': False, 17:06:35 INFO - 'sps_profile_interval': 0, 17:06:35 INFO - 'suite': 'dromaeojs', 17:06:35 INFO - 'system_bits': '32', 17:06:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:35 INFO - 'title': 'talos-linux64-ix-025', 17:06:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:35 INFO - 'use_talos_json': True, 17:06:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:06:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:35 INFO - 'work_dir': 'build'} 17:06:35 INFO - ##### 17:06:35 INFO - ##### Running clobber step. 17:06:35 INFO - ##### 17:06:35 INFO - Running pre-action listener: _resource_record_pre_action 17:06:35 INFO - Running main action method: clobber 17:06:35 INFO - rmtree: /builds/slave/test/build 17:06:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:06:36 INFO - Running post-action listener: _resource_record_post_action 17:06:36 INFO - ##### 17:06:36 INFO - ##### Running read-buildbot-config step. 17:06:36 INFO - ##### 17:06:36 INFO - Running pre-action listener: _resource_record_pre_action 17:06:36 INFO - Running main action method: read_buildbot_config 17:06:36 INFO - Using buildbot properties: 17:06:36 INFO - { 17:06:36 INFO - "project": "", 17:06:36 INFO - "product": "firefox", 17:06:36 INFO - "script_repo_revision": "production", 17:06:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:06:36 INFO - "repository": "", 17:06:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:06:36 INFO - "buildid": "20160418164227", 17:06:36 INFO - "pgo_build": "False", 17:06:36 INFO - "basedir": "/builds/slave/test", 17:06:36 INFO - "buildnumber": 1659, 17:06:36 INFO - "slavename": "talos-linux64-ix-025", 17:06:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:06:36 INFO - "platform": "ubuntu64_hw", 17:06:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:06:36 INFO - "branch": "fx-team", 17:06:36 INFO - "repo_path": "integration/fx-team", 17:06:36 INFO - "revision": "05a9daa3368cb8e32c7393fcb5ff7179023c6c50", 17:06:36 INFO - "stage_platform": "linux64", 17:06:36 INFO - "builduid": "82f2696efcfc4b4c9e980de264f9260b", 17:06:36 INFO - "slavebuilddir": "test" 17:06:36 INFO - } 17:06:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:06:36 INFO - Running post-action listener: _resource_record_post_action 17:06:36 INFO - ##### 17:06:36 INFO - ##### Running download-and-extract step. 17:06:36 INFO - ##### 17:06:36 INFO - Running pre-action listener: _resource_record_pre_action 17:06:36 INFO - Running main action method: download_and_extract 17:06:36 INFO - mkdir: /builds/slave/test/build/tests 17:06: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')]} 17:06:36 INFO - https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:06:45 INFO - Downloaded 1361 bytes. 17:06:45 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:06:45 INFO - Using the following test package requirements: 17:06:45 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:45 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:45 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:06:45 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:45 INFO - u'jsshell-linux-x86_64.zip'], 17:06:45 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:45 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:45 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:06:45 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:06:45 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:45 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:45 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:45 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06: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')]} 17:06:45 INFO - https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:06:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:06:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:50 INFO - Downloaded 22210059 bytes. 17:06:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:06:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:06:51 INFO - Return code: 0 17:06:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:51 INFO - https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:06:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:06:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:06:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:53 INFO - Downloaded 22210059 bytes. 17:06:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:06:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:06:54 INFO - Return code: 0 17:06:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:54 INFO - https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:06:55 INFO - Downloaded 10845952 bytes. 17:06:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:06:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:06:55 INFO - Return code: 0 17:06: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')]} 17:06:55 INFO - https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:06:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:06:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:06:58 INFO - Downloaded 54447892 bytes. 17:06:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:06:58 INFO - mkdir: /builds/slave/test/properties 17:06:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:06:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:06:58 INFO - Contents: 17:06:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:06:58 INFO - Running post-action listener: _resource_record_post_action 17:06:58 INFO - Running post-action listener: set_extra_try_arguments 17:06:58 INFO - ##### 17:06:58 INFO - ##### Running populate-webroot step. 17:06:58 INFO - ##### 17:06:58 INFO - Running pre-action listener: _resource_record_pre_action 17:06:58 INFO - Running main action method: populate_webroot 17:06:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:58 INFO - '--tppagecycles', 17:06:58 INFO - '7'], 17:06:58 INFO - 'tests': ['tsvgm']}}, 17:06:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:06:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:06:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:06:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:58 INFO - 'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:58 INFO - 'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['damp', 'tps']}, 17:06:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:58 INFO - 'tests': ['damp', 'tps']}, 17:06:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['dromaeo_dom']}, 17:06:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['a11yr', 17:06:58 INFO - 'ts_paint', 17:06:58 INFO - 'tpaint', 17:06:58 INFO - 'sessionrestore', 17:06:58 INFO - 'sessionrestore_no_auto_restore', 17:06:58 INFO - 'tabpaint']}, 17:06:58 INFO - 'other-e10s': {'tests': ['a11yr', 17:06:58 INFO - 'ts_paint', 17:06:58 INFO - 'tpaint', 17:06:58 INFO - 'sessionrestore', 17:06:58 INFO - 'sessionrestore_no_auto_restore', 17:06:58 INFO - 'tabpaint']}, 17:06:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:06:58 INFO - 'ts_paint', 17:06:58 INFO - 'tpaint', 17:06:58 INFO - 'sessionrestore', 17:06:58 INFO - 'sessionrestore_no_auto_restore', 17:06:58 INFO - 'tabpaint']}, 17:06:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:06:58 INFO - 'ts_paint', 17:06:58 INFO - 'tpaint', 17:06:58 INFO - 'sessionrestore', 17:06:58 INFO - 'sessionrestore_no_auto_restore', 17:06:58 INFO - 'tabpaint']}, 17:06:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['a11yr', 17:06:58 INFO - 'ts_paint', 17:06:58 INFO - 'tpaint', 17:06:58 INFO - 'sessionrestore', 17:06:58 INFO - 'sessionrestore_no_auto_restore', 17:06:58 INFO - 'tabpaint']}, 17:06:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['a11yr', 17:06:58 INFO - 'ts_paint', 17:06:58 INFO - 'tpaint', 17:06:58 INFO - 'sessionrestore', 17:06:58 INFO - 'sessionrestore_no_auto_restore', 17:06:58 INFO - 'tabpaint']}, 17:06:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['tsvgx', 17:06:58 INFO - 'tsvgr_opacity', 17:06:58 INFO - 'tart', 17:06:58 INFO - 'tscrollx', 17:06:58 INFO - 'cart']}, 17:06:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:06:58 INFO - 'tsvgr_opacity', 17:06:58 INFO - 'tart', 17:06:58 INFO - 'tscrollx', 17:06:58 INFO - 'cart']}, 17:06:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:58 INFO - 'talos_options': ['--disable-e10s'], 17:06:58 INFO - 'tests': ['tp5o']}, 17:06:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:58 INFO - 'tests': ['tp5o']}, 17:06:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:58 INFO - 'talos_options': ['--disable-e10s', 17:06:58 INFO - '--xperf_path', 17:06:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:58 INFO - 'tests': ['tp5n']}, 17:06:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:58 INFO - 'talos_options': ['--xperf_path', 17:06:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:58 INFO - 'tests': ['tp5n']}}, 17:06:58 INFO - 'talos.zip': {'path': '', 17:06:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:58 INFO - Running post-action listener: _resource_record_post_action 17:06:58 INFO - ##### 17:06:58 INFO - ##### Running create-virtualenv step. 17:06:58 INFO - ##### 17:06:58 INFO - Running pre-action listener: _resource_record_pre_action 17:06:58 INFO - Running main action method: create_virtualenv 17:06:58 INFO - Creating virtualenv /builds/slave/test/build/venv 17:06:58 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 17:06:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:06:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:58 INFO - Using real prefix '/usr' 17:06:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:06:59 INFO - Installing distribute.............................................................................................................................................................................................done. 17:07:01 INFO - Installing pip.................done. 17:07:01 INFO - Return code: 0 17:07:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f714e6f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, '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': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', '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 17:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:07:01 INFO - Using env: {'DISPLAY': ':0', 17:07:01 INFO - 'HOME': '/home/cltbld', 17:07:01 INFO - 'LANG': 'en_US.UTF-8', 17:07:01 INFO - 'LANGUAGE': 'en_US:en', 17:07:01 INFO - 'LOGNAME': 'cltbld', 17:07:01 INFO - 'MAIL': '/var/mail/cltbld', 17:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:01 INFO - 'MOZ_NO_REMOTE': '1', 17:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:01 INFO - 'NO_EM_RESTART': '1', 17:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:01 INFO - 'PWD': '/builds/slave/test', 17:07:01 INFO - 'SHELL': '/bin/bash', 17:07:01 INFO - 'SHLVL': '1', 17:07:01 INFO - 'TERM': 'linux', 17:07:01 INFO - 'TMOUT': '86400', 17:07:01 INFO - 'USER': 'cltbld', 17:07:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:01 INFO - '_': '/tools/buildbot/bin/python'} 17:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:01 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 17:07:01 INFO - Cleaning up... 17:07:01 INFO - Return code: 0 17:07:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f714e6f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, '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': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', '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 17:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:07:01 INFO - Using env: {'DISPLAY': ':0', 17:07:01 INFO - 'HOME': '/home/cltbld', 17:07:01 INFO - 'LANG': 'en_US.UTF-8', 17:07:01 INFO - 'LANGUAGE': 'en_US:en', 17:07:01 INFO - 'LOGNAME': 'cltbld', 17:07:01 INFO - 'MAIL': '/var/mail/cltbld', 17:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:01 INFO - 'MOZ_NO_REMOTE': '1', 17:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:01 INFO - 'NO_EM_RESTART': '1', 17:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:01 INFO - 'PWD': '/builds/slave/test', 17:07:01 INFO - 'SHELL': '/bin/bash', 17:07:01 INFO - 'SHLVL': '1', 17:07:01 INFO - 'TERM': 'linux', 17:07:01 INFO - 'TMOUT': '86400', 17:07:01 INFO - 'USER': 'cltbld', 17:07:01 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:01 INFO - '_': '/tools/buildbot/bin/python'} 17:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:01 INFO - Downloading/unpacking psutil>=0.7.1 17:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:07:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:03 INFO - Installing collected packages: psutil 17:07:03 INFO - Running setup.py install for psutil 17:07:03 INFO - building 'psutil._psutil_linux' extension 17:07:03 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 17:07:04 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 17:07:04 INFO - building 'psutil._psutil_posix' extension 17:07:04 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 17:07:04 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 17:07:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:07:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:07:04 INFO - Successfully installed psutil 17:07:04 INFO - Cleaning up... 17:07:04 INFO - Return code: 0 17:07:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f714e6f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, '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': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', '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 17:07:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:07:04 INFO - Using env: {'DISPLAY': ':0', 17:07:04 INFO - 'HOME': '/home/cltbld', 17:07:04 INFO - 'LANG': 'en_US.UTF-8', 17:07:04 INFO - 'LANGUAGE': 'en_US:en', 17:07:04 INFO - 'LOGNAME': 'cltbld', 17:07:04 INFO - 'MAIL': '/var/mail/cltbld', 17:07:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:04 INFO - 'MOZ_NO_REMOTE': '1', 17:07:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:04 INFO - 'NO_EM_RESTART': '1', 17:07:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:04 INFO - 'PWD': '/builds/slave/test', 17:07:04 INFO - 'SHELL': '/bin/bash', 17:07:04 INFO - 'SHLVL': '1', 17:07:04 INFO - 'TERM': 'linux', 17:07:04 INFO - 'TMOUT': '86400', 17:07:04 INFO - 'USER': 'cltbld', 17:07:04 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:04 INFO - '_': '/tools/buildbot/bin/python'} 17:07:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:07:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:07:06 INFO - Installing collected packages: mozsystemmonitor 17:07:06 INFO - Running setup.py install for mozsystemmonitor 17:07:06 INFO - Successfully installed mozsystemmonitor 17:07:06 INFO - Cleaning up... 17:07:06 INFO - Return code: 0 17:07:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f714e6f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, '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': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', '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 17:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:07:06 INFO - Using env: {'DISPLAY': ':0', 17:07:06 INFO - 'HOME': '/home/cltbld', 17:07:06 INFO - 'LANG': 'en_US.UTF-8', 17:07:06 INFO - 'LANGUAGE': 'en_US:en', 17:07:06 INFO - 'LOGNAME': 'cltbld', 17:07:06 INFO - 'MAIL': '/var/mail/cltbld', 17:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:06 INFO - 'MOZ_NO_REMOTE': '1', 17:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:06 INFO - 'NO_EM_RESTART': '1', 17:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:06 INFO - 'PWD': '/builds/slave/test', 17:07:06 INFO - 'SHELL': '/bin/bash', 17:07:06 INFO - 'SHLVL': '1', 17:07:06 INFO - 'TERM': 'linux', 17:07:06 INFO - 'TMOUT': '86400', 17:07:06 INFO - 'USER': 'cltbld', 17:07:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:06 INFO - '_': '/tools/buildbot/bin/python'} 17:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:06 INFO - Downloading/unpacking blobuploader==1.2.4 17:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:08 INFO - Downloading blobuploader-1.2.4.tar.gz 17:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:07:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:07:08 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 17:07:08 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 17:07:08 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 17:07:08 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 17:07:08 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 17:07:08 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 17:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:07:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:07:09 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 17:07:09 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 17:07:09 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 17:07:09 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 17:07:09 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 17:07:09 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 17:07:09 INFO - Downloading docopt-0.6.1.tar.gz 17:07:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:07:09 INFO - Installing collected packages: blobuploader, requests, docopt 17:07:09 INFO - Running setup.py install for blobuploader 17:07:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:07:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:07:09 INFO - Running setup.py install for requests 17:07:09 INFO - Running setup.py install for docopt 17:07:10 INFO - Successfully installed blobuploader requests docopt 17:07:10 INFO - Cleaning up... 17:07:10 INFO - Return code: 0 17:07:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f714e6f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, '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': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', '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 17:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 17:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 17:07:10 INFO - Using env: {'DISPLAY': ':0', 17:07:10 INFO - 'HOME': '/home/cltbld', 17:07:10 INFO - 'LANG': 'en_US.UTF-8', 17:07:10 INFO - 'LANGUAGE': 'en_US:en', 17:07:10 INFO - 'LOGNAME': 'cltbld', 17:07:10 INFO - 'MAIL': '/var/mail/cltbld', 17:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:10 INFO - 'MOZ_NO_REMOTE': '1', 17:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:10 INFO - 'NO_EM_RESTART': '1', 17:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:10 INFO - 'PWD': '/builds/slave/test', 17:07:10 INFO - 'SHELL': '/bin/bash', 17:07:10 INFO - 'SHLVL': '1', 17:07:10 INFO - 'TERM': 'linux', 17:07:10 INFO - 'TMOUT': '86400', 17:07:10 INFO - 'USER': 'cltbld', 17:07:10 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:10 INFO - '_': '/tools/buildbot/bin/python'} 17:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:07:10 INFO - Running setup.py (path:/tmp/pip-ID3QVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:07:10 INFO - Running setup.py (path:/tmp/pip-ITPXGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:07:10 INFO - Running setup.py (path:/tmp/pip-QvR54_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:07:10 INFO - Running setup.py (path:/tmp/pip-yic7in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:07:10 INFO - Running setup.py (path:/tmp/pip-_o2skw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:07:10 INFO - Running setup.py (path:/tmp/pip-hdt0rP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:07:10 INFO - Running setup.py (path:/tmp/pip-mdzkHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:07:10 INFO - Running setup.py (path:/tmp/pip-kXauIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:07:10 INFO - Running setup.py (path:/tmp/pip-TBE36P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:07:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:07:10 INFO - Running setup.py (path:/tmp/pip-nMYPmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:07:11 INFO - Running setup.py (path:/tmp/pip-eGqCLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:07:11 INFO - Running setup.py (path:/tmp/pip-mPM04e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:07:11 INFO - Running setup.py (path:/tmp/pip-3fH07h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:07:11 INFO - Running setup.py (path:/tmp/pip-X4axV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:11 INFO - Running setup.py (path:/tmp/pip-BSfr_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:07:11 INFO - Running setup.py (path:/tmp/pip-N4iUdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:07:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:07:11 INFO - Running setup.py (path:/tmp/pip-oswCEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:07:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:07:11 INFO - Running setup.py install for manifestparser 17:07:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:07:11 INFO - Running setup.py install for mozcrash 17:07:11 INFO - Running setup.py install for mozdebug 17:07:11 INFO - Running setup.py install for mozdevice 17:07:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:07:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Running setup.py install for mozfile 17:07:12 INFO - Running setup.py install for mozhttpd 17:07:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Running setup.py install for mozinfo 17:07:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Running setup.py install for mozInstall 17:07:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Running setup.py install for mozleak 17:07:12 INFO - Running setup.py install for mozlog 17:07:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Running setup.py install for moznetwork 17:07:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Running setup.py install for mozprocess 17:07:12 INFO - Running setup.py install for mozprofile 17:07:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:07:12 INFO - Running setup.py install for mozrunner 17:07:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:07:13 INFO - Running setup.py install for mozscreenshot 17:07:13 INFO - Running setup.py install for moztest 17:07:13 INFO - Running setup.py install for mozversion 17:07:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:07:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:07:13 INFO - Cleaning up... 17:07:13 INFO - Return code: 0 17:07:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f714e6f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, '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': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', '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 17:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:07:13 INFO - Using env: {'DISPLAY': ':0', 17:07:13 INFO - 'HOME': '/home/cltbld', 17:07:13 INFO - 'LANG': 'en_US.UTF-8', 17:07:13 INFO - 'LANGUAGE': 'en_US:en', 17:07:13 INFO - 'LOGNAME': 'cltbld', 17:07:13 INFO - 'MAIL': '/var/mail/cltbld', 17:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:13 INFO - 'MOZ_NO_REMOTE': '1', 17:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:13 INFO - 'NO_EM_RESTART': '1', 17:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:13 INFO - 'PWD': '/builds/slave/test', 17:07:13 INFO - 'SHELL': '/bin/bash', 17:07:13 INFO - 'SHLVL': '1', 17:07:13 INFO - 'TERM': 'linux', 17:07:13 INFO - 'TMOUT': '86400', 17:07:13 INFO - 'USER': 'cltbld', 17:07:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:13 INFO - '_': '/tools/buildbot/bin/python'} 17:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:07:13 INFO - Running setup.py (path:/tmp/pip-5ELPJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:07:13 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)) 17:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:07:13 INFO - Running setup.py (path:/tmp/pip-pGq7Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 17:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:07:13 INFO - Running setup.py (path:/tmp/pip-5_kYjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:07:13 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)) 17:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:07:13 INFO - Running setup.py (path:/tmp/pip-O_RADi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 17:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:07:13 INFO - Running setup.py (path:/tmp/pip-b34Rac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:07:13 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)) 17:07:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:07:13 INFO - Running setup.py (path:/tmp/pip-8sJqxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:07:14 INFO - Running setup.py (path:/tmp/pip-uAy7GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:07:14 INFO - Running setup.py (path:/tmp/pip-RC9QKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:07:14 INFO - Running setup.py (path:/tmp/pip-AVNFzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:07:14 INFO - Running setup.py (path:/tmp/pip-uIXbLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:07:14 INFO - Running setup.py (path:/tmp/pip-cIU4Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:07:14 INFO - Running setup.py (path:/tmp/pip-Q1kQd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:07:14 INFO - Running setup.py (path:/tmp/pip-b9DVt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:07:14 INFO - Running setup.py (path:/tmp/pip-M8TKlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:14 INFO - Running setup.py (path:/tmp/pip-tE_IWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:07:14 INFO - Running setup.py (path:/tmp/pip-eWv52K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:07:14 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)) 17:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:07:14 INFO - Running setup.py (path:/tmp/pip-ByKorq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:07:14 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)) 17:07:14 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:07:14 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)) 17:07:14 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:07:14 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:07:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:16 INFO - Downloading blessings-1.6.tar.gz 17:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:07:16 INFO - Installing collected packages: blessings 17:07:16 INFO - Running setup.py install for blessings 17:07:16 INFO - Successfully installed blessings 17:07:16 INFO - Cleaning up... 17:07:16 INFO - Return code: 0 17:07:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:07:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:17 INFO - Reading from file tmpfile_stdout 17:07:17 INFO - Current package versions: 17:07:17 INFO - argparse == 1.2.1 17:07:17 INFO - blessings == 1.6 17:07:17 INFO - blobuploader == 1.2.4 17:07:17 INFO - docopt == 0.6.1 17:07:17 INFO - manifestparser == 1.1 17:07:17 INFO - mozInstall == 1.12 17:07:17 INFO - mozcrash == 0.17 17:07:17 INFO - mozdebug == 0.1 17:07:17 INFO - mozdevice == 0.48 17:07:17 INFO - mozfile == 1.2 17:07:17 INFO - mozhttpd == 0.7 17:07:17 INFO - mozinfo == 0.9 17:07:17 INFO - mozleak == 0.1 17:07:17 INFO - mozlog == 3.1 17:07:17 INFO - moznetwork == 0.27 17:07:17 INFO - mozprocess == 0.22 17:07:17 INFO - mozprofile == 0.28 17:07:17 INFO - mozrunner == 6.11 17:07:17 INFO - mozscreenshot == 0.1 17:07:17 INFO - mozsystemmonitor == 0.0 17:07:17 INFO - moztest == 0.7 17:07:17 INFO - mozversion == 1.4 17:07:17 INFO - psutil == 3.1.1 17:07:17 INFO - requests == 1.2.3 17:07:17 INFO - wsgiref == 0.1.2 17:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f714e6f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, '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': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', '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 17:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:07:17 INFO - Using env: {'DISPLAY': ':0', 17:07:17 INFO - 'HOME': '/home/cltbld', 17:07:17 INFO - 'LANG': 'en_US.UTF-8', 17:07:17 INFO - 'LANGUAGE': 'en_US:en', 17:07:17 INFO - 'LOGNAME': 'cltbld', 17:07:17 INFO - 'MAIL': '/var/mail/cltbld', 17:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:17 INFO - 'MOZ_NO_REMOTE': '1', 17:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:17 INFO - 'NO_EM_RESTART': '1', 17:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:17 INFO - 'PWD': '/builds/slave/test', 17:07:17 INFO - 'SHELL': '/bin/bash', 17:07:17 INFO - 'SHLVL': '1', 17:07:17 INFO - 'TERM': 'linux', 17:07:17 INFO - 'TMOUT': '86400', 17:07:17 INFO - 'USER': 'cltbld', 17:07:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:17 INFO - '_': '/tools/buildbot/bin/python'} 17:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:07:17 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 2)) 17:07:17 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 3)) 17:07:17 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 4)) 17:07:17 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 5)) 17:07:17 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 6)) 17:07:17 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 7)) 17:07:17 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 8)) 17:07:17 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 9)) 17:07:17 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:07:17 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 4)) 17:07:17 INFO - Cleaning up... 17:07:17 INFO - Return code: 0 17:07:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f714e6f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, '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': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', '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 17:07:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:07:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:07:17 INFO - Using env: {'DISPLAY': ':0', 17:07:17 INFO - 'HOME': '/home/cltbld', 17:07:17 INFO - 'LANG': 'en_US.UTF-8', 17:07:17 INFO - 'LANGUAGE': 'en_US:en', 17:07:17 INFO - 'LOGNAME': 'cltbld', 17:07:17 INFO - 'MAIL': '/var/mail/cltbld', 17:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:17 INFO - 'MOZ_NO_REMOTE': '1', 17:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:17 INFO - 'NO_EM_RESTART': '1', 17:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:17 INFO - 'PWD': '/builds/slave/test', 17:07:17 INFO - 'SHELL': '/bin/bash', 17:07:17 INFO - 'SHLVL': '1', 17:07:17 INFO - 'TERM': 'linux', 17:07:17 INFO - 'TMOUT': '86400', 17:07:17 INFO - 'USER': 'cltbld', 17:07:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:17 INFO - '_': '/tools/buildbot/bin/python'} 17:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:17 INFO - Downloading/unpacking jsonschema 17:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:07:19 INFO - Downloading/unpacking functools32 (from jsonschema) 17:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:07:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:07:19 INFO - warning: no files found matching '*.txt' 17:07:19 INFO - no previously-included directories found matching 'build' 17:07:19 INFO - no previously-included directories found matching 'dist' 17:07:19 INFO - no previously-included directories found matching '.git*' 17:07:19 INFO - Installing collected packages: jsonschema, functools32 17:07:19 INFO - Running setup.py install for functools32 17:07:19 INFO - warning: no files found matching '*.txt' 17:07:19 INFO - no previously-included directories found matching 'build' 17:07:19 INFO - no previously-included directories found matching 'dist' 17:07:19 INFO - no previously-included directories found matching '.git*' 17:07:19 INFO - Successfully installed jsonschema functools32 17:07:19 INFO - Cleaning up... 17:07:19 INFO - Return code: 0 17:07:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f714e6f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x115d5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, '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': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', '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 17:07:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 17:07:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 17:07:19 INFO - Using env: {'DISPLAY': ':0', 17:07:19 INFO - 'HOME': '/home/cltbld', 17:07:19 INFO - 'LANG': 'en_US.UTF-8', 17:07:19 INFO - 'LANGUAGE': 'en_US:en', 17:07:19 INFO - 'LOGNAME': 'cltbld', 17:07:19 INFO - 'MAIL': '/var/mail/cltbld', 17:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:19 INFO - 'MOZ_NO_REMOTE': '1', 17:07:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:19 INFO - 'NO_EM_RESTART': '1', 17:07:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:19 INFO - 'PWD': '/builds/slave/test', 17:07:19 INFO - 'SHELL': '/bin/bash', 17:07:19 INFO - 'SHLVL': '1', 17:07:19 INFO - 'TERM': 'linux', 17:07:19 INFO - 'TMOUT': '86400', 17:07:19 INFO - 'USER': 'cltbld', 17:07:19 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:19 INFO - '_': '/tools/buildbot/bin/python'} 17:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:20 INFO - Downloading/unpacking flake8 17:07:20 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 17:07:20 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 17:07:20 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 17:07:20 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 17:07:20 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 17:07:20 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 17:07:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:07:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:07:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 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 17:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:07:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:22 INFO - no previously-included directories found matching 'docs/_build' 17:07:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:07:22 INFO - Running setup.py install for pep8 17:07:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:22 INFO - no previously-included directories found matching 'docs/_build' 17:07:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:07:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:07:22 INFO - Cleaning up... 17:07:23 INFO - Return code: 0 17:07:23 INFO - Running post-action listener: _resource_record_post_action 17:07:23 INFO - Running post-action listener: _start_resource_monitoring 17:07:23 INFO - Starting resource monitoring. 17:07:23 INFO - ##### 17:07:23 INFO - ##### Running install step. 17:07:23 INFO - ##### 17:07:23 INFO - Running pre-action listener: _resource_record_pre_action 17:07:23 INFO - Running main action method: install 17:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:07:23 INFO - Reading from file tmpfile_stdout 17:07:23 INFO - Detecting whether we're running mozinstall >=1.0... 17:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:07:23 INFO - Reading from file tmpfile_stdout 17:07:23 INFO - Output received: 17:07:23 INFO - Usage: mozinstall [options] installer 17:07:23 INFO - Options: 17:07:23 INFO - -h, --help show this help message and exit 17:07:23 INFO - -d DEST, --destination=DEST 17:07:23 INFO - Directory to install application into. [default: 17:07:23 INFO - "/builds/slave/test"] 17:07:23 INFO - --app=APP Application being installed. [default: firefox] 17:07:23 INFO - mkdir: /builds/slave/test/build/application 17:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:07:39 INFO - Reading from file tmpfile_stdout 17:07:39 INFO - Output received: 17:07:39 INFO - /builds/slave/test/build/application/firefox/firefox 17:07:39 INFO - Running post-action listener: _resource_record_post_action 17:07:39 INFO - ##### 17:07:39 INFO - ##### Running run-tests step. 17:07:39 INFO - ##### 17:07:39 INFO - Running pre-action listener: _resource_record_pre_action 17:07:39 INFO - Running main action method: run_tests 17:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:07:39 INFO - Python 2.7.3 17:07:39 INFO - Return code: 0 17:07:39 INFO - grabbing minidump binary from tooltool 17:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:39 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 0x11ec410>, '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 0x11ed310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11ed7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:07:39 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 17:07:39 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 17:07:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:39 INFO - Return code: 0 17:07:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:07:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:07:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:07:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:07:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:07:40 INFO - Return code: 0 17:07:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:07:40 INFO - Using env: {'DISPLAY': ':0', 17:07:40 INFO - 'HOME': '/home/cltbld', 17:07:40 INFO - 'LANG': 'en_US.UTF-8', 17:07:40 INFO - 'LANGUAGE': 'en_US:en', 17:07:40 INFO - 'LOGNAME': 'cltbld', 17:07:40 INFO - 'MAIL': '/var/mail/cltbld', 17:07:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:07:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:40 INFO - 'MOZ_NO_REMOTE': '1', 17:07:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:40 INFO - 'NO_EM_RESTART': '1', 17:07:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:07:40 INFO - 'PWD': '/builds/slave/test', 17:07:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:07:40 INFO - 'SHELL': '/bin/bash', 17:07:40 INFO - 'SHLVL': '1', 17:07:40 INFO - 'TERM': 'linux', 17:07:40 INFO - 'TMOUT': '86400', 17:07:40 INFO - 'USER': 'cltbld', 17:07:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1461024090.849090-678595068', 17:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:40 INFO - '_': '/tools/buildbot/bin/python'} 17:07:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:07:40 INFO - mozversion application_buildid: 20160418164227 17:07:40 INFO - mozversion application_changeset: 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 17:07:40 INFO - mozversion application_display_name: Nightly 17:07:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:40 INFO - mozversion application_name: Firefox 17:07:40 INFO - mozversion application_remotingname: firefox 17:07:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:07:40 INFO - mozversion application_vendor: Mozilla 17:07:40 INFO - mozversion application_version: 48.0a1 17:07:40 INFO - mozversion platform_buildid: 20160418164227 17:07:40 INFO - mozversion platform_changeset: 05a9daa3368cb8e32c7393fcb5ff7179023c6c50 17:07:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:07:40 INFO - mozversion platform_version: 48.0a1 17:07:40 INFO - using testdate: 1461024460 17:07:40 INFO - actual date: 1461024460 17:07:40 INFO - starting webserver on 'localhost:42112' 17:07:40 INFO - SUITE-START | Running 2 tests 17:07:40 INFO - TEST-START | dromaeo_css 17:07:40 INFO - operating with platform_type : linux_ 17:07:40 INFO - Initialising browser for dromaeo_css test... 17:07:40 INFO - TEST-INFO | started process 15802 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNnG3R/profile http://localhost:42112/getInfo.html) 17:07:44 INFO - PROCESS | 15802 | __metrics Screen width/height:1600/1200 17:07:44 INFO - PROCESS | 15802 | colorDepth:24 17:07:44 INFO - PROCESS | 15802 | Browser inner width/height: 1024/697 17:07:44 INFO - PROCESS | 15802 | __metrics 17:07:45 ERROR - PROCESS | 15802 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:07:46 INFO - TEST-INFO | 15802: exit 0 17:07:46 INFO - Browser initialized. 17:07:46 INFO - Running cycle 1/1 for dromaeo_css test... 17:07:46 INFO - TEST-INFO | started process 15886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNnG3R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:58 INFO - PROCESS | 15886 | RSS: Main: 154677248 17:07:58 INFO - PROCESS | 15886 | 17:08:49 INFO - PROCESS | 15886 | 1461024529677 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] 17:11:01 INFO - PROCESS | 15886 | Cycle 1(1): loaded http://localhost:42112/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42112/tests/dromaeo/cssquery-ext.html) 17:11:02 INFO - PROCESS | 15886 | RSS: Main: 261824512 17:11:02 INFO - PROCESS | 15886 | 17:14:04 INFO - PROCESS | 15886 | Cycle 1(1): loaded http://localhost:42112/tests/dromaeo/cssquery-ext.html (next: http://localhost:42112/tests/dromaeo/cssquery-jquery.html) 17:14:05 INFO - PROCESS | 15886 | RSS: Main: 236343296 17:14:05 INFO - PROCESS | 15886 | 17:17:07 INFO - PROCESS | 15886 | Cycle 1(1): loaded http://localhost:42112/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42112/tests/dromaeo/cssquery-mootools.html) 17:17:08 INFO - PROCESS | 15886 | RSS: Main: 232996864 17:17:08 INFO - PROCESS | 15886 | 17:20:10 INFO - PROCESS | 15886 | Cycle 1(1): loaded http://localhost:42112/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42112/tests/dromaeo/cssquery-prototype.html) 17:20:10 INFO - PROCESS | 15886 | RSS: Main: 231272448 17:20:10 INFO - PROCESS | 15886 | 17:23:13 INFO - PROCESS | 15886 | Cycle 1(1): loaded http://localhost:42112/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42112/tests/dromaeo/cssquery-yui.html) 17:23:14 INFO - PROCESS | 15886 | RSS: Main: 214126592 17:23:14 INFO - PROCESS | 15886 | 17:26:17 INFO - PROCESS | 15886 | Cycle 1(1): loaded http://localhost:42112/tests/dromaeo/cssquery-yui.html (next: http://localhost:42112/tests/dromaeo/cssquery-dojo.html) 17:26:17 INFO - PROCESS | 15886 | RSS: Main: 268472320 17:26:17 INFO - PROCESS | 15886 | 17:26:17 INFO - PROCESS | 15886 | __start_tp_report 17:26:17 INFO - PROCESS | 15886 | _x_x_mozilla_page_load 17:26:17 INFO - PROCESS | 15886 | _x_x_mozilla_page_load_details 17:26:17 INFO - PROCESS | 15886 | |i|pagename|runs| 17:26:17 INFO - PROCESS | 15886 | |0;dojo.html;2594.377349436135;2659.5478768609346;2678.0225217795487;2679.83920964742;2703.6755589329273;4585.060062687149;4630.467496237934;4642;4652.976345204058;4731.101090792756;4699.177643912319;4731.90536189276;4776.546228108333;4800.759962001904;4825.662203645747;4292.849750258742;4295.119500502406;4301.913961720764;4340.045190058182;4355.324924636687;4245.596668316505;4369.759663218521;4372.060007098473;4394.428724265841;4409.625181859546;4307.375430562551;4327.653787696977;4329.264025115738;4351.6953813233085;4376.168527979674;4247.702660813744;4250;4269.615734583902;4279.272523670983;4364.170807546588;4280.315149576084;4280.978595107035;4284.05750734841;4292.5063617683745;4333.241682705514;4500.054988452429;4535.410396648447;4569.246074397721;4569.908601827945;4573.153966516205;4822.614190864722;4950.158473059589;5000.799968001312;5033.647644664875;5050.419201791804;4919.163742163841;4924.409070911478;4929.383827021622;4945.7774400152075;4980;4519;4593.83921562747;4602.355670206207;4610.74640894754;4646.535346465326;5126;5141.845744627667;5157.638965272395;5191.610629202825;5214.0875346814155;4939.357883475125;4969.552740253323;4970.52779985908;4973.626977976666;5020.824271150565;4824.469308376076;5001.44984051754;5040.218766091261;5056.06462804375;5066.771995260222;4912.8771780705765;4928.704277743347;4938.802447902115;4941.505849415102;4979.526944940225;4900.681455705368;4901.975490122527;4903.583195428429;4908.460069392364;4947.777350019258;4150.460440142762;4221.831126754895;4229.450171477688;4236.597523235288;4292.12011537634;3653.2328211075974;3683.1528748387486;3690.833912473945;3719.1817800083936;3746.8501259949844;4301.2472817257485;4304.548022457597;4310.655147588185;4318.3090705486975;4357.67317451186;4813.855584332476;5028.371453568304;5030.572401345927;5038.193888977746;5094.439611642716;4276.5295817460055;4291.291936830388;4299.247631664446;4301.870943871689;4326.6754993375625;4435.290353543418;4457.821687132543;4472.1502914446155;4473.664475164375;4509.503954564995;4609.608183304323;4639.884002899819;4713.858584242478;4737.407824021997;4785.665003449725;4987.226979818134;5006.674566153189;5015.523525265094;5019.623528235324;5064.772085256099;4726;4752.144613969519;4757.548032936866;4760.476347601831;4782.713037217639;4809.110314591811;4928.778204980713;4951.084049450863;4995.300657907968;5008.749562521933;4947.579455746302;4957.454679985127;4979.502049794992;4986.576141028053;5030.496950304941;4831.806727730851;4835.83811579354;4837.7097374157665;4841.273808928548;4889.657723959289;4710.222813235915;4796.37647105874;4864.051509955525;4864.537868902448;4892.951070489249;4753.95246047549;4768.76156192196;4769.713817170981;4770.737609431515;4814.15752243363;4865.36750222483;4869.245266983623;4870.196417591058;4870.634702397264;4873.3664623600125;4660.347551342747;4769.928451073306;4796.06476737033;4841.782119804688;4845.176320025534 17:26:17 INFO - PROCESS | 15886 | |1;ext.html;570.1789423230548;599.7091410665827;615.5383462403198;619.0652115305887;625.9718312675935;26341.209763707095;34582.135446613815;35255.11862203443;35278.64721352786;35369.82315088427;36474.27051458969;37284.81357593208;37291.4406283906;37353.25293494129;37355.43966840499;7713.6914523419;7820.217978202163;7877.172896845835;7894.64474098667;7900.091489478697;7623.428242881779;7752.379809615245;7752.7674169775;7753.612319384037;7862.803429914241;7856;7898.289153976141;7902.328302094329;7931.484453510532;7959.96020019902;7874.803129921769;7906.881396778996;7922.286994170552;7924.722634707815;7928.246816552476;7908.762737117896;8012.5192488450875;8013.599320034034;8018.158093400168;8019.238172373615;37835.24329513422;38287.617123828684;38297.425538616946;38381.424278635845;38408.42387364192;2792.176307989148;2889.2921234297523;3080.1991482214785;3646.9635303646887;3665.4318580620047;28407.147785566467;28643.427131457254;28656.570151447744;28841.711582884112;29745.40509189804;3163.8418079095954;3236.158598764315;3242.8864989725485;3254.886078987224;3277.754168437377;223710.99999999837;223952;225150;226453;226838;52651.73674131682;53038.46961530335;53045.73477132589;53111.73444132755;53259;58479.70760146172;59680;59864;60100.39899601036;60229.69885150546;14826.555203343916;15046.623834404227;15052.698946021019;15070.09579425238;15100;11179.60871369498;11225.270357426742;11387.37369444672;11510.424478776027;11538.653840384803;18503.629927401646;18536.721949170773;18578.907105464386;18579.44261672152;18587.721184181977;6915.239323674392;7008.369246767816;7151.2491188424465;7151.499395042297;7277;810.4488947515746;883.9204471597459;910.7313342563959;947.9952600236954;1049.6431213387484;27297.317567060585;28993.85503072471;29722;31100.222494437367;31866.362672746414;974.1768205866032;985.5959056786826;1013.7414959185361;1062.2245760594656;1093.9835902461468;13976.580702578938;14608.123512589278;14659.780103298459;14760.48338308154;14806.72202137364;314636;320674;321098;322117;322376;47338.763306183246;48246;48456.27315590269;48478.757606211744;48539.75730121327;1075.2634445404922;1160.802663547199;1213.4721396192685;1281.3465132782535;1284.7045179608742;25065;27051.1884643461;27374.72625273722;27805.721942780314;27869.303267418476;36930.26139477249;37750.2449951005;37768.811155944044;37807.43288850615;37820.24359512849;225235;229388;230477;230941;231041;22674.43313917165;24902.875485622455;25144.24567262985;25292.482451052994;25917;33269.16827079342;36744.03955465978;39542.60457395389;40302.59697402988;40515.18969620532;32842.83578582092;37202.8139859299;38362.23275534529;38454.42318365283;38471.80764096162;34288.65711342855;34957.30085398227;34985.65014349926;35072.824635876656;35144.824275878455;35174.29651407008;35456.645433546364;35907.28185436329;36005.0998725034;36064.09839754027;33788.83105584457;34094;34398.312033759685;34661.13347166341;37889.62110378861;25709.871450642626;26658;26667.466650667266;26674.46651066929;26736.866315668296 17:26:17 INFO - PROCESS | 15886 | |2;jquery.html;379.3323750199648;383.36170276489645;385.189176782872;389.1535909397061;396.58358723340484;15748.370065197392;16633.916830415845;16998.093162625963;17154;17190.22643981019;16191.595210119753;16582.08798516081;17442.30230790767;17467.126643667798;17476.912615436937;4616.699914505563;4737.24204127338;4765.451973023095;4767.809287628508;4773.880652983668;3403.5405220295193;5082.288479612857;5386.676799392029;5391.541718953894;5397.946020539804;5377.946220537803;5380.892382152355;5381.273528073699;5397.7571009304675;5400.054990376688;5021.447640759532;5328.893422131555;5333.839984800462;5335.546478549328;5336.199570064483;3354.9832250838836;4881.951180488185;5213.139831927728;5213.478652134756;5215.217717342391;11767.882321176765;11773.234739741974;11972.461239244169;12040.458179381862;12645.620631381073;1845.1973391574709;1873.784514780804;1882.3223639489772;1890.5935223926922;1940.5283379927816;8996.955015224881;9527.618895244183;9551.713448596553;9640.132388085107;9865.112139907444;1743.755874177616;1746.2840235503384;1757.7187649975942;1808.5569035586366;1840.2546968477789;66557.66721166411;69752.65123674349;69888;70199.64900175466;70773;8068.91069705594;8462.280706140047;8627.827443451095;8779.122087791298;10062.345947513388;11183.552657893755;11223.494942727597;11232.663020109247;11257;11282.097432205404;6820.658967051727;6929.203141638776;6995.635851009106;7039.894401583981;7092.822679433056;7016.158061032606;7102.112235970504;7164.319389657974;7293.635318234174;7376.520526165782;3616.5660120785146;3681.4477828325967;3714.888553343404;3749.7937613431523;3759.3609086455367;1692.1792930428733;1760.2782859027736;1780.2522940365077;1794.5962158514492;1862.4040307101868;863.5639002303922;888.5690440136528;898.1377877237794;902.8058967322057;923.6166990698919;15485.458008969632;15737.134457604712;15863.52409427719;15889.920550397404;16460.341586336413;850.510956200175;879.4986857491297;893.5398269891011;915.2677857713802;927.295255605731;8913.197812196933;9225.295099499304;9550.522473876279;9604.375715578464;9664.178544823768;299653;307531;366582;375687;377089;81610.18389816026;82377.58811206026;83983;85231.5738421304;86101;973.3916302311055;983.0120728667644;997.2747147434833;1029.5933106422922;1031.097789434245;14244.430222791387;14372.856271437151;14373.209473479059;14586.927065364605;14733.410663573766;35036;35578;35704.464433033005;35935.64064359323;36037.81981090078;44438.3334249993;46381.072378551566;49694;50539.74730126326;51309.376373297586;7407.8148046299275;7466.850662986819;7577.962110189635;7625.428092892944;7633.0458692663415;8844.823103538021;10814.405207713336;11429.371384573928;11550;11965.341906195243;9860.901390986286;10175.542100605342;10181.541830617492;10341.9482902585;10372;9791.85312220303;9889.456079915673;9953.153981911619;9991.25065620067;10023.398596084258;10080.143187828824;10264.178865690876;10407.115395191493;10426.426546540013;10511.894881051092;7334.449916256195;7375.262473752582;7528.962355188189;7547.207543207884;7633.69465221385;7982.882396464383;9593.472359020321;10083.647072352433;10206.132478739093;10376.481175941022 17:26:17 INFO - PROCESS | 15886 | |3;mootools.html;1250.2623452163223;1425.144913052169;1441.0057060628167;1578.7710781936619;1774.920128594214;7318.670659820307;7603.657835397406;7621.771346859596;7633.122190948043;7644.770656880302;7460.32857042866;7514.211007844179;7596.468247222697;7601.315881570657;7604.277593628596;1924.8460123190112;1987.1951859496855;2189.8467107302495;2229.799318061378;2257.841951063426;2227.4208705736464;2251.6847641330146;2261.4233370490583;2262.1856131792542;2265.6148454762647;2197.461621902636;2213.1479380438486;2240.4958884250996;2241.8542794718373;2242.0807468937737;1874.2502998800453;2076.730025096743;2138.764735879052;2142.914283428661;2179.814715749163;2187.059564387313;2189.5839790439763;2198.758136604972;2206.5476577301774;2211.1487077475126;7573.5834529100875;7646.082470103567;7770.067591888953;7858.292753652198;7885;4553.453585569753;4740.478547359788;4745.857624271277;4758.928616070762;4786.21027530457;2826.561882908132;2845.47358738634;2848.7195676707715;2885.480613489592;2900.0864727610947;931.1759093202564;940.8259471997634;947.3510645208055;953.1707414549317;957.8898426680951;10483.056524912794;10497.212709046775;10532.578696852117;10539.63111291101;10539.683809485728;4036.29364861154;4156.937645935313;4259.212045771542;4288.91422171561;4392.802323895432;8936.24041956428;8998;8998.64005439775;9001.234895033995;9005.414648047856;4605.148047611203;4616.146012987541;4626.051659409813;4634.698744581591;4636.281376386665;3566.625504322061;4097.549269580344;4213.47331583552;4213.705040647186;4220.85227017053;3572.392693242103;3604.2070744436182;3653.397189463762;3710.8330125144435;3735.14091758897;1194.814803705427;1205.52984336109;1218.5125949620224;1232.1744431231098;1238.133306685324;820.1962077164293;823.263179454385;838.8112674648155;840.8066144786733;849.885265489151;5083.38999320084;5210.7915683373;5226.712530810766;5450.509454149145;5532.861678458071;836.9862537666883;881.8897637795276;902.1474706402387;910.6402970826618;916.1571354354011;3718.1076541629814;3769.1707824278615;3798.905027374338;3815.7901315427916;3827.1962887793875;8718.825623487495;8970.730878073668;9129.08709129095;9133.40632858862;9242.72271831846;9099.772505687279;9212.723618291462;9237.03011183816;9247.26021918245;9257.166854983085;7084.36240738336;7299.41604671625;7344.26557344272;7443.925560744432;7445.4415918805225;5331.120365139708;5331.360236771612;5354.973225133849;5403.189521571796;5557.916631250454;8937.329700272636;8949.105089490999;9023.142801433853;9052.864207037032;9075.682351117679;8362.874556881774;8775.736727898173;8776.868346974928;8780;9069.455832650063;5996.190514280691;6569.343065693392;6608.173978252718;6730.990351447322;6764.289749576224;7276.7089316426745;7322.450816188913;7368.37368823656;7382.483226174117;7388.335049845539;6485.156929599122;6680;6744.0895479109695;6804.591724496546;6815.863682726417;6751.122354093936;6812.693428795816;6812.795616131524;6848.280930502226;6875.278095799869;6327.96836015817;6387.425131738166;6427.196600424947;6434.678266086583;6446.742130314922;4555.202839503007;4630.6295496359535;4671.719696818202;4711.81152753886;4760.595624290773;4624.1445332613575;4704.542161511355;4704.858854234379;4736.052789442057;4814 17:26:17 INFO - PROCESS | 15886 | |4;prototype.html;302.4344475830198;312.24125375337934;312.72792670376776;314.0750489807517;317.70929599416536;5087.847364579059;5103.821366252182;5110.999999999995;5124.846254612367;5166.07010738067;5051;5052.317937078503;5053.166227572456;5059.59523238141;5066.164082926312;3749.8875033748964;3840.577536470986;3868.2263547290513;3975.4036894465917;3986.3023970804993;3975.1254723960683;3992.960070399288;3996.8001599920035;3998.9200215995807;4003.319435695939;3740.2145549434517;3934.013323271744;3940.1725637616137;3942.3100957332354;3944.881653550384;3822.9044273893096;3962.5641179470235;3971.106501037272;3979.1047014421524;3981.084350599364;3527.805970671612;3532.73904700989;3534.6642069003406;3544.326577950181;3553.6446355364515;4853.490383509751;4883.096627123958;4891.192953162724;4895.241237608141;4910.288008238786;4347.8695639130565;4561.452625684906;4587.79354929029;4591.127685739699;4605.30920361945;5270.183121616117;5334.653247538898;5351.197320401932;5371.382291036542;5380.569554435636;3889.2804831106337;3893.260280546687;3896.5129358830145;3896.7077469189926;3903.7852918089493;5499.092649712793;5561.749721262553;5623.569622530254;5662.094064949588;5668.688222147822;3988.222296652183;4007.6994225432627;4008.118213992917;4010.057636455431;4013.779242141652;4056.472658554369;4063.878083657495;4064.04494943688;4069.9389509157386;4075.5313138989395;4408.338749187584;4574.656900732459;4581;4583.083383323348;4588.311753236974;5313.362396512443;5332.573394128461;5335.33308336458;5349.277847490539;5356.3572371315695;1387.840398354182;1407.92960351982;1408.112888879999;1412.2232771975373;1416.178616402484;883.8099808541194;920.5949382271779;946.4132238012477;957.3298690916387;961.0437614573544;4601.493835678073;4605.976970115128;4610.308453731967;4626.1441633297945;4647.767611619405;5432.130859062531;5455.235887237873;5455.509004189642;5455.781768729285;5467.917981230285;4498.977505112453;4588.678792484494;4624.745638989888;4632.745199014019;4641.118187544355;2886.8123571967753;2907.3749143934156;2910.898118565882;2918.97081029187;2936.765058795291;5138.537531622097;5140.588752899759;5145.4597267287145;5149.536541711264;5170.5346518813485;5336.59853066114;5522.5581953443625;5557.777688892399;5562.471565201299;5568.6658800472105;5047.823326183566;5112.642115051911;5114.974425127851;5126.333576635014;5141.434442211354;5345.024855992921;5418.187271909245;5419.214213938878;5435.864103397446;5461.890762184814;5214.713190774392;5328.17413300939;5338.1992701093595;5339.492748188916;5358.517733403856;5077.263796749525;5102.351818449826;5129.204973229155;5132.281480592795;5151.25306830515;3946.3883098119836;3953.6441720245316;3955.723099383131;3956.3076461619676;3959.406089086545;5291.23277124807;5600.411956744646;5604.943950560605;5606.271184745957;5608.775648973995;5365.490278423699;5375.46245375475;5380.43505431924;5386.434424385383;5403.297571315861;5220.269162317202;5390.326209223847;5414.593905457185;5421.105517589711;5423.349198096096;4913.680610760289;5278.551323137576;5310.230016647642;5320.14877619579;5330.387005494263;5228.268042474133;5401.918971215514;5426.918596220981;5430.592705547021;5442.836714898559;5278.973605132103;5293.311869456946;5300.655457395257;5305.495977882095;5310.150375939831 17:26:17 INFO - PROCESS | 15886 | |5;yui.html;646.405307117452;707.6850801393375;740.4520654715509;765.5177238339845;768.4275214964852;11525.827112593317;11543.942280288597;11546.422678866065;11570.59502917397;12223.083268754846;12570.18293810904;13254.337283135852;13280.33598320085;13297.335133243347;13313.334333283321;640.785336912135;778.6534991928594;810.5582457560644;811.9878201826963;815.1115284340068;807.1928071928072;811.3833486550235;811.4157806379397;811.930985866202;812.6261919517029;842.4481964313385;844.8521508735977;845.7462761171655;847.5338563789891;847.6524624903791;669.5647828911198;826.7354446577098;835.0271933197818;837.6523742646795;845.9280961118312;618.2426527503817;618.7865186510646;618.8731310081467;620.3269452643842;621.9471344935686;11945.223560468628;11959;12082.15424920256;12088.697782555419;12094.455749491293;11033.944830275797;11284.943575282154;11346.751857295774;11395.829062564067;11528.193026488148;9619.56711947964;10048.296619236657;10264.281500294983;10354.17166626668;10459.84310235347;3280;3285.6385797562248;3352.932941341184;3352.949705754416;3408.3694516514524;49907.2513912288;50263;50273.49726502725;50306.245406318936;50442.24336634953;9660.32377733566;9683.854742178873;9774.804503910023;10068.39589624625;10098.293119481566;17441.30234790594;17463.47609571715;17487.213075411637;17489.125543722763;17539.912300438416;6687.4984376171005;6739.460843132538;6779.186497620317;6787.796366109024;6952.513324067267;3727.4408838674417;3769.246150769857;3803.4294855771304;3805.562360328542;3810.9809450952566;2466.3710753757678;2573.8198326117367;2575.562154433751;2576.9613455798176;2578.4456341886585;436.2670713201788;476.7568540044602;482.2645465664889;486.88503327380613;488.78737749079266;535.8097875254228;573.6414740787009;605.2132228103447;622.4677900395097;626.9686515674198;7837.531177679013;7871.252231038042;8048.59529233107;8317.542535160625;8472.703455379033;583.8073435766187;595.7736060297059;613.6410200033031;634.3434545245649;635.5043066408209;3707.6848467879995;3720.6093360197333;3751.1372384351207;3788.1476667749534;3819.7899115548357;45023.774881125384;46829.76585117052;46944.061118777434;54984.725076374365;56096.43903560994;41609.37585936213;42901;43451.56548434538;43697.78151109224;44270.77864610721;36993;40150.79924600358;40545;40608.79695601562;40869.79565102155;7835.529868207926;8194.918050819415;8308.875366869623;8360.038595561346;8405;28790.856045719636;29111.272218194714;29462.558061629523;29540.96606618758;31353.37293254168;42055.57944420516;42083.579164207964;42340;42399;43384.13231735411;11210.383428911162;11319.830202547133;11402.144839136932;11430.314181149157;11728.648140555797;11891.464884080064;12041;12076.51693932233;12239.265644061385;12284.754304914031;9822.950885245527;10149.34029288094;10184.745381365525;10251.58993640246;10327.431991240554;9928.751781205528;10199.490025498844;10373.63692270797;10378.896211038094;10902.127829773757;10665.41340226295;10695.304805187638;11240.83138752903;11254.268472549258;11293.43532823372;9642.807143857224;9862.260330475387;9930.702078937355;9955.303128780915;10169.593216271267;9173.862392063991;9550.808983820423;9563.330566860253;9743.951280243553;9787.755306117118 17:26:17 INFO - PROCESS | 15886 | __end_tp_report 17:26:17 INFO - PROCESS | 15886 | __start_cc_report 17:26:17 INFO - PROCESS | 15886 | _x_x_mozilla_cycle_collect,997 17:26:17 INFO - PROCESS | 15886 | __end_cc_report 17:26:17 INFO - PROCESS | 15886 | __startTimestamp1461025577547__endTimestamp 17:26:17 INFO - PROCESS | 15886 | 17:26:17 INFO - PROCESS | 15886 | ------- Summary: start ------- 17:26:17 INFO - PROCESS | 15886 | Number of tests: 6 17:26:17 INFO - PROCESS | 15886 | 17:26:17 INFO - PROCESS | 15886 | [#0] dojo.html Cycles:165 Average:4612.73 Median:4760.48 stddev:473.41 (9.9%) stddev-sans-first:447.61 17:26:17 INFO - PROCESS | 15886 | Values: 2594.4 2659.5 2678.0 2679.8 2703.7 4585.1 4630.5 4642.0 4653.0 4731.1 4699.2 4731.9 4776.5 4800.8 4825.7 4292.8 4295.1 4301.9 4340.0 4355.3 4245.6 4369.8 4372.1 4394.4 4409.6 4307.4 4327.7 4329.3 4351.7 4376.2 4247.7 4250.0 4269.6 4279.3 4364.2 4280.3 4281.0 4284.1 4292.5 4333.2 4500.1 4535.4 4569.2 4569.9 4573.2 4822.6 4950.2 5000.8 5033.6 5050.4 4919.2 4924.4 4929.4 4945.8 4980.0 4519.0 4593.8 4602.4 4610.7 4646.5 5126.0 5141.8 5157.6 5191.6 5214.1 4939.4 4969.6 4970.5 4973.6 5020.8 4824.5 5001.4 5040.2 5056.1 5066.8 4912.9 4928.7 4938.8 4941.5 4979.5 4900.7 4902.0 4903.6 4908.5 4947.8 4150.5 4221.8 4229.5 4236.6 4292.1 3653.2 3683.2 3690.8 3719.2 3746.9 4301.2 4304.5 4310.7 4318.3 4357.7 4813.9 5028.4 5030.6 5038.2 5094.4 4276.5 4291.3 4299.2 4301.9 4326.7 4435.3 4457.8 4472.2 4473.7 4509.5 4609.6 4639.9 4713.9 4737.4 4785.7 4987.2 5006.7 5015.5 5019.6 5064.8 4726.0 4752.1 4757.5 4760.5 4782.7 4809.1 4928.8 4951.1 4995.3 5008.7 4947.6 4957.5 4979.5 4986.6 5030.5 4831.8 4835.8 4837.7 4841.3 4889.7 4710.2 4796.4 4864.1 4864.5 4893.0 4754.0 4768.8 4769.7 4770.7 4814.2 4865.4 4869.2 4870.2 4870.6 4873.4 4660.3 4769.9 4796.1 4841.8 4845.2 17:26:17 INFO - PROCESS | 15886 | 17:26:17 INFO - PROCESS | 15886 | [#1] ext.html Cycles:180 Average:42111.05 Median:35214.71 stddev:68452.64 (194.4%) stddev-sans-first:68573.61 17:26:17 INFO - PROCESS | 15886 | Values: 570.2 599.7 615.5 619.1 626.0 26341.2 34582.1 35255.1 35278.6 35369.8 36474.3 37284.8 37291.4 37353.3 37355.4 7713.7 7820.2 7877.2 7894.6 7900.1 7623.4 7752.4 7752.8 7753.6 7862.8 7856.0 7898.3 7902.3 7931.5 7960.0 7874.8 7906.9 7922.3 7924.7 7928.2 7908.8 8012.5 8013.6 8018.2 8019.2 37835.2 38287.6 38297.4 38381.4 38408.4 2792.2 2889.3 3080.2 3647.0 3665.4 28407.1 28643.4 28656.6 28841.7 29745.4 3163.8 3236.2 3242.9 3254.9 3277.8 223711.0 223952.0 225150.0 226453.0 226838.0 52651.7 53038.5 53045.7 53111.7 53259.0 58479.7 59680.0 59864.0 60100.4 60229.7 14826.6 15046.6 15052.7 15070.1 15100.0 11179.6 11225.3 11387.4 11510.4 11538.7 18503.6 18536.7 18578.9 18579.4 18587.7 6915.2 7008.4 7151.2 7151.5 7277.0 810.4 883.9 910.7 948.0 1049.6 27297.3 28993.9 29722.0 31100.2 31866.4 974.2 985.6 1013.7 1062.2 1094.0 13976.6 14608.1 14659.8 14760.5 14806.7 314636.0 320674.0 321098.0 322117.0 322376.0 47338.8 48246.0 48456.3 48478.8 48539.8 1075.3 1160.8 1213.5 1281.3 1284.7 25065.0 27051.2 27374.7 27805.7 27869.3 36930.3 37750.2 37768.8 37807.4 37820.2 225235.0 229388.0 230477.0 230941.0 231041.0 22674.4 24902.9 25144.2 25292.5 25917.0 33269.2 36744.0 39542.6 40302.6 40515.2 32842.8 37202.8 38362.2 38454.4 38471.8 34288.7 34957.3 34985.7 35072.8 35144.8 35174.3 35456.6 35907.3 36005.1 36064.1 33788.8 34094.0 34398.3 34661.1 37889.6 25709.9 26658.0 26667.5 26674.5 26736.9 17:26:17 INFO - PROCESS | 15886 | 17:26:17 INFO - PROCESS | 15886 | [#2] jquery.html Cycles:180 Average:22652.37 Median:4751.35 stddev:57867.88 (1217.9%) stddev-sans-first:58006.05 17:26:17 INFO - PROCESS | 15886 | Values: 379.3 383.4 385.2 389.2 396.6 15748.4 16633.9 16998.1 17154.0 17190.2 16191.6 16582.1 17442.3 17467.1 17476.9 4616.7 4737.2 4765.5 4767.8 4773.9 3403.5 5082.3 5386.7 5391.5 5397.9 5377.9 5380.9 5381.3 5397.8 5400.1 5021.4 5328.9 5333.8 5335.5 5336.2 3355.0 4882.0 5213.1 5213.5 5215.2 11767.9 11773.2 11972.5 12040.5 12645.6 1845.2 1873.8 1882.3 1890.6 1940.5 8997.0 9527.6 9551.7 9640.1 9865.1 1743.8 1746.3 1757.7 1808.6 1840.3 66557.7 69752.7 69888.0 70199.6 70773.0 8068.9 8462.3 8627.8 8779.1 10062.3 11183.6 11223.5 11232.7 11257.0 11282.1 6820.7 6929.2 6995.6 7039.9 7092.8 7016.2 7102.1 7164.3 7293.6 7376.5 3616.6 3681.4 3714.9 3749.8 3759.4 1692.2 1760.3 1780.3 1794.6 1862.4 863.6 888.6 898.1 902.8 923.6 15485.5 15737.1 15863.5 15889.9 16460.3 850.5 879.5 893.5 915.3 927.3 8913.2 9225.3 9550.5 9604.4 9664.2 299653.0 307531.0 366582.0 375687.0 377089.0 81610.2 82377.6 83983.0 85231.6 86101.0 973.4 983.0 997.3 1029.6 1031.1 14244.4 14372.9 14373.2 14586.9 14733.4 35036.0 35578.0 35704.5 35935.6 36037.8 44438.3 46381.1 49694.0 50539.7 51309.4 7407.8 7466.9 7578.0 7625.4 7633.0 8844.8 10814.4 11429.4 11550.0 11965.3 9860.9 10175.5 10181.5 10341.9 10372.0 9791.9 9889.5 9953.2 9991.3 10023.4 10080.1 10264.2 10407.1 10426.4 10511.9 7334.4 7375.3 7529.0 7547.2 7633.7 7982.9 9593.5 10083.6 10206.1 10376.5 17:26:17 INFO - PROCESS | 15886 | 17:26:17 INFO - PROCESS | 15886 | [#3] mootools.html Cycles:180 Average:5105.33 Median:5379.08 stddev:2795.96 (52.0%) stddev-sans-first:2788.79 17:26:17 INFO - PROCESS | 15886 | Values: 1250.3 1425.1 1441.0 1578.8 1774.9 7318.7 7603.7 7621.8 7633.1 7644.8 7460.3 7514.2 7596.5 7601.3 7604.3 1924.8 1987.2 2189.8 2229.8 2257.8 2227.4 2251.7 2261.4 2262.2 2265.6 2197.5 2213.1 2240.5 2241.9 2242.1 1874.3 2076.7 2138.8 2142.9 2179.8 2187.1 2189.6 2198.8 2206.5 2211.1 7573.6 7646.1 7770.1 7858.3 7885.0 4553.5 4740.5 4745.9 4758.9 4786.2 2826.6 2845.5 2848.7 2885.5 2900.1 931.2 940.8 947.4 953.2 957.9 10483.1 10497.2 10532.6 10539.6 10539.7 4036.3 4156.9 4259.2 4288.9 4392.8 8936.2 8998.0 8998.6 9001.2 9005.4 4605.1 4616.1 4626.1 4634.7 4636.3 3566.6 4097.5 4213.5 4213.7 4220.9 3572.4 3604.2 3653.4 3710.8 3735.1 1194.8 1205.5 1218.5 1232.2 1238.1 820.2 823.3 838.8 840.8 849.9 5083.4 5210.8 5226.7 5450.5 5532.9 837.0 881.9 902.1 910.6 916.2 3718.1 3769.2 3798.9 3815.8 3827.2 8718.8 8970.7 9129.1 9133.4 9242.7 9099.8 9212.7 9237.0 9247.3 9257.2 7084.4 7299.4 7344.3 7443.9 7445.4 5331.1 5331.4 5355.0 5403.2 5557.9 8937.3 8949.1 9023.1 9052.9 9075.7 8362.9 8775.7 8776.9 8780.0 9069.5 5996.2 6569.3 6608.2 6731.0 6764.3 7276.7 7322.5 7368.4 7382.5 7388.3 6485.2 6680.0 6744.1 6804.6 6815.9 6751.1 6812.7 6812.8 6848.3 6875.3 6328.0 6387.4 6427.2 6434.7 6446.7 4555.2 4630.6 4671.7 4711.8 4760.6 4624.1 4704.5 4704.9 4736.1 4814.0 17:26:17 INFO - PROCESS | 15886 | 17:26:17 INFO - PROCESS | 15886 | [#4] prototype.html Cycles:180 Average:4435.41 Median:5062.88 stddev:1276.36 (25.2%) stddev-sans-first:1241.67 17:26:17 INFO - PROCESS | 15886 | Values: 302.4 312.2 312.7 314.1 317.7 5087.8 5103.8 5111.0 5124.8 5166.1 5051.0 5052.3 5053.2 5059.6 5066.2 3749.9 3840.6 3868.2 3975.4 3986.3 3975.1 3993.0 3996.8 3998.9 4003.3 3740.2 3934.0 3940.2 3942.3 3944.9 3822.9 3962.6 3971.1 3979.1 3981.1 3527.8 3532.7 3534.7 3544.3 3553.6 4853.5 4883.1 4891.2 4895.2 4910.3 4347.9 4561.5 4587.8 4591.1 4605.3 5270.2 5334.7 5351.2 5371.4 5380.6 3889.3 3893.3 3896.5 3896.7 3903.8 5499.1 5561.7 5623.6 5662.1 5668.7 3988.2 4007.7 4008.1 4010.1 4013.8 4056.5 4063.9 4064.0 4069.9 4075.5 4408.3 4574.7 4581.0 4583.1 4588.3 5313.4 5332.6 5335.3 5349.3 5356.4 1387.8 1407.9 1408.1 1412.2 1416.2 883.8 920.6 946.4 957.3 961.0 4601.5 4606.0 4610.3 4626.1 4647.8 5432.1 5455.2 5455.5 5455.8 5467.9 4499.0 4588.7 4624.7 4632.7 4641.1 2886.8 2907.4 2910.9 2919.0 2936.8 5138.5 5140.6 5145.5 5149.5 5170.5 5336.6 5522.6 5557.8 5562.5 5568.7 5047.8 5112.6 5115.0 5126.3 5141.4 5345.0 5418.2 5419.2 5435.9 5461.9 5214.7 5328.2 5338.2 5339.5 5358.5 5077.3 5102.4 5129.2 5132.3 5151.3 3946.4 3953.6 3955.7 3956.3 3959.4 5291.2 5600.4 5604.9 5606.3 5608.8 5365.5 5375.5 5380.4 5386.4 5403.3 5220.3 5390.3 5414.6 5421.1 5423.3 4913.7 5278.6 5310.2 5320.1 5330.4 5228.3 5401.9 5426.9 5430.6 5442.8 5279.0 5293.3 5300.7 5305.5 5310.2 17:26:17 INFO - PROCESS | 15886 | 17:26:17 INFO - PROCESS | 15886 | [#5] yui.html Cycles:180 Average:12731.85 Median:43142.57 stddev:14436.88 (33.5%) stddev-sans-first:14448.85 17:26:17 INFO - PROCESS | 15886 | Values: 646.4 707.7 740.5 765.5 768.4 11525.8 11543.9 11546.4 11570.6 12223.1 12570.2 13254.3 13280.3 13297.3 13313.3 640.8 778.7 810.6 812.0 815.1 807.2 811.4 811.4 811.9 812.6 842.4 844.9 845.7 847.5 847.7 669.6 826.7 835.0 837.7 845.9 618.2 618.8 618.9 620.3 621.9 11945.2 11959.0 12082.2 12088.7 12094.5 11033.9 11284.9 11346.8 11395.8 11528.2 9619.6 10048.3 10264.3 10354.2 10459.8 3280.0 3285.6 3352.9 3352.9 3408.4 49907.3 50263.0 50273.5 50306.2 50442.2 9660.3 9683.9 9774.8 10068.4 10098.3 17441.3 17463.5 17487.2 17489.1 17539.9 6687.5 6739.5 6779.2 6787.8 6952.5 3727.4 3769.2 3803.4 3805.6 3811.0 2466.4 2573.8 2575.6 2577.0 2578.4 436.3 476.8 482.3 486.9 488.8 535.8 573.6 605.2 622.5 627.0 7837.5 7871.3 8048.6 8317.5 8472.7 583.8 595.8 613.6 634.3 635.5 3707.7 3720.6 3751.1 3788.1 3819.8 45023.8 46829.8 46944.1 54984.7 56096.4 41609.4 42901.0 43451.6 43697.8 44270.8 36993.0 40150.8 40545.0 40608.8 40869.8 7835.5 8194.9 8308.9 8360.0 8405.0 28790.9 29111.3 29462.6 29541.0 31353.4 42055.6 42083.6 42340.0 42399.0 43384.1 11210.4 11319.8 11402.1 11430.3 11728.6 11891.5 12041.0 12076.5 12239.3 12284.8 9823.0 10149.3 10184.7 10251.6 10327.4 9928.8 10199.5 10373.6 10378.9 10902.1 10665.4 10695.3 11240.8 11254.3 11293.4 9642.8 9862.3 9930.7 9955.3 10169.6 9173.9 9550.8 9563.3 9744.0 9787.8 17:26:17 INFO - PROCESS | 15886 | -------- Summary: end -------- 17:26:17 INFO - PROCESS | 15886 | 17:26:18 INFO - TEST-INFO | 15886: exit 0 17:26:18 INFO - TEST-OK | dromaeo_css | took 1118044ms 17:26:18 INFO - TEST-START | kraken 17:26:18 INFO - operating with platform_type : linux_ 17:26:18 INFO - Initialising browser for kraken test... 17:26:18 INFO - TEST-INFO | started process 16062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvqZrQE/profile http://localhost:42112/getInfo.html) 17:26:22 INFO - PROCESS | 16062 | __metrics Screen width/height:1600/1200 17:26:22 INFO - PROCESS | 16062 | colorDepth:24 17:26:22 INFO - PROCESS | 16062 | Browser inner width/height: 1024/697 17:26:22 INFO - PROCESS | 16062 | __metrics 17:26:23 ERROR - PROCESS | 16062 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:26:24 INFO - TEST-INFO | 16062: exit 0 17:26:24 INFO - Browser initialized. 17:26:24 INFO - Running cycle 1/1 for kraken test... 17:26:24 INFO - TEST-INFO | started process 16141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvqZrQE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:36 INFO - PROCESS | 16141 | RSS: Main: 154787840 17:26:36 INFO - PROCESS | 16141 | 17:26:38 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42112/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:39 INFO - PROCESS | 16141 | RSS: Main: 209702912 17:26:39 INFO - PROCESS | 16141 | 17:26:42 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42112/tests/kraken/driver.html?testName=audio-dft) 17:26:43 INFO - PROCESS | 16141 | RSS: Main: 195514368 17:26:43 INFO - PROCESS | 16141 | 17:26:46 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42112/tests/kraken/driver.html?testName=audio-fft) 17:26:47 INFO - PROCESS | 16141 | RSS: Main: 266657792 17:26:47 INFO - PROCESS | 16141 | 17:26:49 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42112/tests/kraken/driver.html?testName=audio-oscillator) 17:26:49 INFO - PROCESS | 16141 | RSS: Main: 174174208 17:26:49 INFO - PROCESS | 16141 | 17:26:52 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42112/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:52 INFO - PROCESS | 16141 | RSS: Main: 178429952 17:26:52 INFO - PROCESS | 16141 | 17:26:55 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42112/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:56 INFO - PROCESS | 16141 | RSS: Main: 214138880 17:26:56 INFO - PROCESS | 16141 | 17:26:59 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42112/tests/kraken/driver.html?testName=imaging-desaturate) 17:27:00 INFO - PROCESS | 16141 | RSS: Main: 214708224 17:27:00 INFO - PROCESS | 16141 | 17:27:03 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42112/tests/kraken/driver.html?testName=json-parse-financial) 17:27:03 INFO - PROCESS | 16141 | RSS: Main: 215576576 17:27:03 INFO - PROCESS | 16141 | 17:27:05 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42112/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:27:06 INFO - PROCESS | 16141 | RSS: Main: 201072640 17:27:06 INFO - PROCESS | 16141 | 17:27:08 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42112/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:27:08 INFO - PROCESS | 16141 | RSS: Main: 206467072 17:27:08 INFO - PROCESS | 16141 | 17:27:10 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42112/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:27:11 INFO - PROCESS | 16141 | RSS: Main: 219852800 17:27:11 INFO - PROCESS | 16141 | 17:27:14 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:27:14 INFO - PROCESS | 16141 | RSS: Main: 224206848 17:27:14 INFO - PROCESS | 16141 | 17:27:17 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:27:18 INFO - PROCESS | 16141 | RSS: Main: 216678400 17:27:18 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | Cycle 1(1): loaded http://localhost:42112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42112/tests/kraken/driver.html?testName=ai-astar) 17:27:20 INFO - PROCESS | 16141 | RSS: Main: 279949312 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | __start_tp_report 17:27:20 INFO - PROCESS | 16141 | _x_x_mozilla_page_load 17:27:20 INFO - PROCESS | 16141 | _x_x_mozilla_page_load_details 17:27:20 INFO - PROCESS | 16141 | |i|pagename|runs| 17:27:20 INFO - PROCESS | 16141 | |0;ai-astar;112;114;109;112;114;113;103;113;113;114 17:27:20 INFO - PROCESS | 16141 | |1;audio-beat-detection;157;135;156;191;133;164;165;132;181;133 17:27:20 INFO - PROCESS | 16141 | |2;audio-dft;163;162;161;162;163;162;162;161;162;162 17:27:20 INFO - PROCESS | 16141 | |3;audio-fft;75;74;116;113;78;74;73;112;104;74 17:27:20 INFO - PROCESS | 16141 | |4;audio-oscillator;93;94;145;94;93;94;145;94;95;136 17:27:20 INFO - PROCESS | 16141 | |5;imaging-gaussian-blur;116;117;117;117;117;117;118;117;117;117 17:27:20 INFO - PROCESS | 16141 | |6;imaging-darkroom;146;146;146;146;146;145;146;145;146;145 17:27:20 INFO - PROCESS | 16141 | |7;imaging-desaturate;94;95;95;95;94;95;95;96;96;95 17:27:20 INFO - PROCESS | 16141 | |8;json-parse-financial;64;63;64;65;65;64;65;80;62;63 17:27:20 INFO - PROCESS | 16141 | |9;json-stringify-tinderbox;65;65;65;65;66;65;65;65;66;65 17:27:20 INFO - PROCESS | 16141 | |10;stanford-crypto-aes;80;81;79;89;82;89;82;82;81;81 17:27:20 INFO - PROCESS | 16141 | |11;stanford-crypto-ccm;134;136;131;146;133;134;132;138;167;146 17:27:20 INFO - PROCESS | 16141 | |12;stanford-crypto-pbkdf2;182;184;179;181;177;183;180;176;175;178 17:27:20 INFO - PROCESS | 16141 | |13;stanford-crypto-sha256-iterative;76;72;73;72;72;73;72;72;72;74 17:27:20 INFO - PROCESS | 16141 | __end_tp_report 17:27:20 INFO - PROCESS | 16141 | __start_cc_report 17:27:20 INFO - PROCESS | 16141 | _x_x_mozilla_cycle_collect,1910 17:27:20 INFO - PROCESS | 16141 | __end_cc_report 17:27:20 INFO - PROCESS | 16141 | __startTimestamp1461025640646__endTimestamp 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | ------- Summary: start ------- 17:27:20 INFO - PROCESS | 16141 | Number of tests: 14 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.40 (3.0%) stddev-sans-first:3.61 17:27:20 INFO - PROCESS | 16141 | Values: 112.0 114.0 109.0 112.0 114.0 113.0 103.0 113.0 113.0 114.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#1] audio-beat-detection Cycles:10 Average:154.70 Median:160.50 stddev:21.22 (13.2%) stddev-sans-first:22.50 17:27:20 INFO - PROCESS | 16141 | Values: 157.0 135.0 156.0 191.0 133.0 164.0 165.0 132.0 181.0 133.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.60 17:27:20 INFO - PROCESS | 16141 | Values: 163.0 162.0 161.0 162.0 163.0 162.0 162.0 161.0 162.0 162.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#3] audio-fft Cycles:10 Average:89.30 Median:74.00 stddev:19.17 (25.9%) stddev-sans-first:19.62 17:27:20 INFO - PROCESS | 16141 | Values: 75.0 74.0 116.0 113.0 78.0 74.0 73.0 112.0 104.0 74.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:94.00 stddev:23.39 (24.9%) stddev-sans-first:24.15 17:27:20 INFO - PROCESS | 16141 | Values: 93.0 94.0 145.0 94.0 93.0 94.0 145.0 94.0 95.0 136.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 17:27:20 INFO - PROCESS | 16141 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:27:20 INFO - PROCESS | 16141 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 145.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 17:27:20 INFO - PROCESS | 16141 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 96.0 95.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:64.50 stddev:5.19 (8.0%) stddev-sans-first:5.48 17:27:20 INFO - PROCESS | 16141 | Values: 64.0 63.0 64.0 65.0 65.0 64.0 65.0 80.0 62.0 63.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 17:27:20 INFO - PROCESS | 16141 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 65.0 65.0 66.0 65.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:3.50 (4.3%) stddev-sans-first:3.59 17:27:20 INFO - PROCESS | 16141 | Values: 80.0 81.0 79.0 89.0 82.0 89.0 82.0 82.0 81.0 81.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:137.00 stddev:10.99 (8.0%) stddev-sans-first:11.46 17:27:20 INFO - PROCESS | 16141 | Values: 134.0 136.0 131.0 146.0 133.0 134.0 132.0 138.0 167.0 146.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:180.50 stddev:3.03 (1.7%) stddev-sans-first:3.07 17:27:20 INFO - PROCESS | 16141 | Values: 182.0 184.0 179.0 181.0 177.0 183.0 180.0 176.0 175.0 178.0 17:27:20 INFO - PROCESS | 16141 | 17:27:20 INFO - PROCESS | 16141 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.50 stddev:1.32 (1.8%) stddev-sans-first:0.73 17:27:20 INFO - PROCESS | 16141 | Values: 76.0 72.0 73.0 72.0 72.0 73.0 72.0 72.0 72.0 74.0 17:27:20 INFO - PROCESS | 16141 | -------- Summary: end -------- 17:27:20 INFO - PROCESS | 16141 | 17:27:21 INFO - TEST-INFO | 16141: exit 0 17:27:21 INFO - TEST-OK | kraken | took 63331ms 17:27:21 INFO - SUITE-END | took 1181s 17:27:21 INFO - Completed test suite (00:19:41) 17:27:21 INFO - javascript benchmark 17:27:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.377349436135, 2659.5478768609346, 2678.0225217795487, 2679.83920964742, 2703.6755589329273, 4585.060062687149, 4630.467496237934, 4642.0, 4652.976345204058, 4731.101090792756, 4699.177643912319, 4731.90536189276, 4776.546228108333, 4800.759962001904, 4825.662203645747, 4292.849750258742, 4295.119500502406, 4301.913961720764, 4340.045190058182, 4355.324924636687, 4245.596668316505, 4369.759663218521, 4372.060007098473, 4394.428724265841, 4409.625181859546, 4307.375430562551, 4327.653787696977, 4329.264025115738, 4351.6953813233085, 4376.168527979674, 4247.702660813744, 4250.0, 4269.615734583902, 4279.272523670983, 4364.170807546588, 4280.315149576084, 4280.978595107035, 4284.05750734841, 4292.5063617683745, 4333.241682705514, 4500.054988452429, 4535.410396648447, 4569.246074397721, 4569.908601827945, 4573.153966516205, 4822.614190864722, 4950.158473059589, 5000.799968001312, 5033.647644664875, 5050.419201791804, 4919.163742163841, 4924.409070911478, 4929.383827021622, 4945.7774400152075, 4980.0, 4519.0, 4593.83921562747, 4602.355670206207, 4610.74640894754, 4646.535346465326, 5126.0, 5141.845744627667, 5157.638965272395, 5191.610629202825, 5214.0875346814155, 4939.357883475125, 4969.552740253323, 4970.52779985908, 4973.626977976666, 5020.824271150565, 4824.469308376076, 5001.44984051754, 5040.218766091261, 5056.06462804375, 5066.771995260222, 4912.8771780705765, 4928.704277743347, 4938.802447902115, 4941.505849415102, 4979.526944940225, 4900.681455705368, 4901.975490122527, 4903.583195428429, 4908.460069392364, 4947.777350019258, 4150.460440142762, 4221.831126754895, 4229.450171477688, 4236.597523235288, 4292.12011537634, 3653.2328211075974, 3683.1528748387486, 3690.833912473945, 3719.1817800083936, 3746.8501259949844, 4301.2472817257485, 4304.548022457597, 4310.655147588185, 4318.3090705486975, 4357.67317451186, 4813.855584332476, 5028.371453568304, 5030.572401345927, 5038.193888977746, 5094.439611642716, 4276.5295817460055, 4291.291936830388, 4299.247631664446, 4301.870943871689, 4326.6754993375625, 4435.290353543418, 4457.821687132543, 4472.1502914446155, 4473.664475164375, 4509.503954564995, 4609.608183304323, 4639.884002899819, 4713.858584242478, 4737.407824021997, 4785.665003449725, 4987.226979818134, 5006.674566153189, 5015.523525265094, 5019.623528235324, 5064.772085256099, 4726.0, 4752.144613969519, 4757.548032936866, 4760.476347601831, 4782.713037217639, 4809.110314591811, 4928.778204980713, 4951.084049450863, 4995.300657907968, 5008.749562521933, 4947.579455746302, 4957.454679985127, 4979.502049794992, 4986.576141028053, 5030.496950304941, 4831.806727730851, 4835.83811579354, 4837.7097374157665, 4841.273808928548, 4889.657723959289, 4710.222813235915, 4796.37647105874, 4864.051509955525, 4864.537868902448, 4892.951070489249, 4753.95246047549, 4768.76156192196, 4769.713817170981, 4770.737609431515, 4814.15752243363, 4865.36750222483, 4869.245266983623, 4870.196417591058, 4870.634702397264, 4873.3664623600125, 4660.347551342747, 4769.928451073306, 4796.06476737033, 4841.782119804688, 4845.176320025534], "value": 4583.43470043403, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.1789423230548, 599.7091410665827, 615.5383462403198, 619.0652115305887, 625.9718312675935, 26341.209763707095, 34582.135446613815, 35255.11862203443, 35278.64721352786, 35369.82315088427, 36474.27051458969, 37284.81357593208, 37291.4406283906, 37353.25293494129, 37355.43966840499, 7713.6914523419, 7820.217978202163, 7877.172896845835, 7894.64474098667, 7900.091489478697, 7623.428242881779, 7752.379809615245, 7752.7674169775, 7753.612319384037, 7862.803429914241, 7856.0, 7898.289153976141, 7902.328302094329, 7931.484453510532, 7959.96020019902, 7874.803129921769, 7906.881396778996, 7922.286994170552, 7924.722634707815, 7928.246816552476, 7908.762737117896, 8012.5192488450875, 8013.599320034034, 8018.158093400168, 8019.238172373615, 37835.24329513422, 38287.617123828684, 38297.425538616946, 38381.424278635845, 38408.42387364192, 2792.176307989148, 2889.2921234297523, 3080.1991482214785, 3646.9635303646887, 3665.4318580620047, 28407.147785566467, 28643.427131457254, 28656.570151447744, 28841.711582884112, 29745.40509189804, 3163.8418079095954, 3236.158598764315, 3242.8864989725485, 3254.886078987224, 3277.754168437377, 223710.99999999837, 223952.0, 225150.0, 226453.0, 226838.0, 52651.73674131682, 53038.46961530335, 53045.73477132589, 53111.73444132755, 53259.0, 58479.70760146172, 59680.0, 59864.0, 60100.39899601036, 60229.69885150546, 14826.555203343916, 15046.623834404227, 15052.698946021019, 15070.09579425238, 15100.0, 11179.60871369498, 11225.270357426742, 11387.37369444672, 11510.424478776027, 11538.653840384803, 18503.629927401646, 18536.721949170773, 18578.907105464386, 18579.44261672152, 18587.721184181977, 6915.239323674392, 7008.369246767816, 7151.2491188424465, 7151.499395042297, 7277.0, 810.4488947515746, 883.9204471597459, 910.7313342563959, 947.9952600236954, 1049.6431213387484, 27297.317567060585, 28993.85503072471, 29722.0, 31100.222494437367, 31866.362672746414, 974.1768205866032, 985.5959056786826, 1013.7414959185361, 1062.2245760594656, 1093.9835902461468, 13976.580702578938, 14608.123512589278, 14659.780103298459, 14760.48338308154, 14806.72202137364, 314636.0, 320674.0, 321098.0, 322117.0, 322376.0, 47338.763306183246, 48246.0, 48456.27315590269, 48478.757606211744, 48539.75730121327, 1075.2634445404922, 1160.802663547199, 1213.4721396192685, 1281.3465132782535, 1284.7045179608742, 25065.0, 27051.1884643461, 27374.72625273722, 27805.721942780314, 27869.303267418476, 36930.26139477249, 37750.2449951005, 37768.811155944044, 37807.43288850615, 37820.24359512849, 225235.0, 229388.0, 230477.0, 230941.0, 231041.0, 22674.43313917165, 24902.875485622455, 25144.24567262985, 25292.482451052994, 25917.0, 33269.16827079342, 36744.03955465978, 39542.60457395389, 40302.59697402988, 40515.18969620532, 32842.83578582092, 37202.8139859299, 38362.23275534529, 38454.42318365283, 38471.80764096162, 34288.65711342855, 34957.30085398227, 34985.65014349926, 35072.824635876656, 35144.824275878455, 35174.29651407008, 35456.645433546364, 35907.28185436329, 36005.0998725034, 36064.09839754027, 33788.83105584457, 34094.0, 34398.312033759685, 34661.13347166341, 37889.62110378861, 25709.871450642626, 26658.0, 26667.466650667266, 26674.46651066929, 26736.866315668296], "value": 17202.14012381225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3323750199648, 383.36170276489645, 385.189176782872, 389.1535909397061, 396.58358723340484, 15748.370065197392, 16633.916830415845, 16998.093162625963, 17154.0, 17190.22643981019, 16191.595210119753, 16582.08798516081, 17442.30230790767, 17467.126643667798, 17476.912615436937, 4616.699914505563, 4737.24204127338, 4765.451973023095, 4767.809287628508, 4773.880652983668, 3403.5405220295193, 5082.288479612857, 5386.676799392029, 5391.541718953894, 5397.946020539804, 5377.946220537803, 5380.892382152355, 5381.273528073699, 5397.7571009304675, 5400.054990376688, 5021.447640759532, 5328.893422131555, 5333.839984800462, 5335.546478549328, 5336.199570064483, 3354.9832250838836, 4881.951180488185, 5213.139831927728, 5213.478652134756, 5215.217717342391, 11767.882321176765, 11773.234739741974, 11972.461239244169, 12040.458179381862, 12645.620631381073, 1845.1973391574709, 1873.784514780804, 1882.3223639489772, 1890.5935223926922, 1940.5283379927816, 8996.955015224881, 9527.618895244183, 9551.713448596553, 9640.132388085107, 9865.112139907444, 1743.755874177616, 1746.2840235503384, 1757.7187649975942, 1808.5569035586366, 1840.2546968477789, 66557.66721166411, 69752.65123674349, 69888.0, 70199.64900175466, 70773.0, 8068.91069705594, 8462.280706140047, 8627.827443451095, 8779.122087791298, 10062.345947513388, 11183.552657893755, 11223.494942727597, 11232.663020109247, 11257.0, 11282.097432205404, 6820.658967051727, 6929.203141638776, 6995.635851009106, 7039.894401583981, 7092.822679433056, 7016.158061032606, 7102.112235970504, 7164.319389657974, 7293.635318234174, 7376.520526165782, 3616.5660120785146, 3681.4477828325967, 3714.888553343404, 3749.7937613431523, 3759.3609086455367, 1692.1792930428733, 1760.2782859027736, 1780.2522940365077, 1794.5962158514492, 1862.4040307101868, 863.5639002303922, 888.5690440136528, 898.1377877237794, 902.8058967322057, 923.6166990698919, 15485.458008969632, 15737.134457604712, 15863.52409427719, 15889.920550397404, 16460.341586336413, 850.510956200175, 879.4986857491297, 893.5398269891011, 915.2677857713802, 927.295255605731, 8913.197812196933, 9225.295099499304, 9550.522473876279, 9604.375715578464, 9664.178544823768, 299653.0, 307531.0, 366582.0, 375687.0, 377089.0, 81610.18389816026, 82377.58811206026, 83983.0, 85231.5738421304, 86101.0, 973.3916302311055, 983.0120728667644, 997.2747147434833, 1029.5933106422922, 1031.097789434245, 14244.430222791387, 14372.856271437151, 14373.209473479059, 14586.927065364605, 14733.410663573766, 35036.0, 35578.0, 35704.464433033005, 35935.64064359323, 36037.81981090078, 44438.3334249993, 46381.072378551566, 49694.0, 50539.74730126326, 51309.376373297586, 7407.8148046299275, 7466.850662986819, 7577.962110189635, 7625.428092892944, 7633.0458692663415, 8844.823103538021, 10814.405207713336, 11429.371384573928, 11550.0, 11965.341906195243, 9860.901390986286, 10175.542100605342, 10181.541830617492, 10341.9482902585, 10372.0, 9791.85312220303, 9889.456079915673, 9953.153981911619, 9991.25065620067, 10023.398596084258, 10080.143187828824, 10264.178865690876, 10407.115395191493, 10426.426546540013, 10511.894881051092, 7334.449916256195, 7375.262473752582, 7528.962355188189, 7547.207543207884, 7633.69465221385, 7982.882396464383, 9593.472359020321, 10083.647072352433, 10206.132478739093, 10376.481175941022], "value": 7851.17555564019, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.2623452163223, 1425.144913052169, 1441.0057060628167, 1578.7710781936619, 1774.920128594214, 7318.670659820307, 7603.657835397406, 7621.771346859596, 7633.122190948043, 7644.770656880302, 7460.32857042866, 7514.211007844179, 7596.468247222697, 7601.315881570657, 7604.277593628596, 1924.8460123190112, 1987.1951859496855, 2189.8467107302495, 2229.799318061378, 2257.841951063426, 2227.4208705736464, 2251.6847641330146, 2261.4233370490583, 2262.1856131792542, 2265.6148454762647, 2197.461621902636, 2213.1479380438486, 2240.4958884250996, 2241.8542794718373, 2242.0807468937737, 1874.2502998800453, 2076.730025096743, 2138.764735879052, 2142.914283428661, 2179.814715749163, 2187.059564387313, 2189.5839790439763, 2198.758136604972, 2206.5476577301774, 2211.1487077475126, 7573.5834529100875, 7646.082470103567, 7770.067591888953, 7858.292753652198, 7885.0, 4553.453585569753, 4740.478547359788, 4745.857624271277, 4758.928616070762, 4786.21027530457, 2826.561882908132, 2845.47358738634, 2848.7195676707715, 2885.480613489592, 2900.0864727610947, 931.1759093202564, 940.8259471997634, 947.3510645208055, 953.1707414549317, 957.8898426680951, 10483.056524912794, 10497.212709046775, 10532.578696852117, 10539.63111291101, 10539.683809485728, 4036.29364861154, 4156.937645935313, 4259.212045771542, 4288.91422171561, 4392.802323895432, 8936.24041956428, 8998.0, 8998.64005439775, 9001.234895033995, 9005.414648047856, 4605.148047611203, 4616.146012987541, 4626.051659409813, 4634.698744581591, 4636.281376386665, 3566.625504322061, 4097.549269580344, 4213.47331583552, 4213.705040647186, 4220.85227017053, 3572.392693242103, 3604.2070744436182, 3653.397189463762, 3710.8330125144435, 3735.14091758897, 1194.814803705427, 1205.52984336109, 1218.5125949620224, 1232.1744431231098, 1238.133306685324, 820.1962077164293, 823.263179454385, 838.8112674648155, 840.8066144786733, 849.885265489151, 5083.38999320084, 5210.7915683373, 5226.712530810766, 5450.509454149145, 5532.861678458071, 836.9862537666883, 881.8897637795276, 902.1474706402387, 910.6402970826618, 916.1571354354011, 3718.1076541629814, 3769.1707824278615, 3798.905027374338, 3815.7901315427916, 3827.1962887793875, 8718.825623487495, 8970.730878073668, 9129.08709129095, 9133.40632858862, 9242.72271831846, 9099.772505687279, 9212.723618291462, 9237.03011183816, 9247.26021918245, 9257.166854983085, 7084.36240738336, 7299.41604671625, 7344.26557344272, 7443.925560744432, 7445.4415918805225, 5331.120365139708, 5331.360236771612, 5354.973225133849, 5403.189521571796, 5557.916631250454, 8937.329700272636, 8949.105089490999, 9023.142801433853, 9052.864207037032, 9075.682351117679, 8362.874556881774, 8775.736727898173, 8776.868346974928, 8780.0, 9069.455832650063, 5996.190514280691, 6569.343065693392, 6608.173978252718, 6730.990351447322, 6764.289749576224, 7276.7089316426745, 7322.450816188913, 7368.37368823656, 7382.483226174117, 7388.335049845539, 6485.156929599122, 6680.0, 6744.0895479109695, 6804.591724496546, 6815.863682726417, 6751.122354093936, 6812.693428795816, 6812.795616131524, 6848.280930502226, 6875.278095799869, 6327.96836015817, 6387.425131738166, 6427.196600424947, 6434.678266086583, 6446.742130314922, 4555.202839503007, 4630.6295496359535, 4671.719696818202, 4711.81152753886, 4760.595624290773, 4624.1445332613575, 4704.542161511355, 4704.858854234379, 4736.052789442057, 4814.0], "value": 4141.282376566903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.4344475830198, 312.24125375337934, 312.72792670376776, 314.0750489807517, 317.70929599416536, 5087.847364579059, 5103.821366252182, 5110.999999999995, 5124.846254612367, 5166.07010738067, 5051.0, 5052.317937078503, 5053.166227572456, 5059.59523238141, 5066.164082926312, 3749.8875033748964, 3840.577536470986, 3868.2263547290513, 3975.4036894465917, 3986.3023970804993, 3975.1254723960683, 3992.960070399288, 3996.8001599920035, 3998.9200215995807, 4003.319435695939, 3740.2145549434517, 3934.013323271744, 3940.1725637616137, 3942.3100957332354, 3944.881653550384, 3822.9044273893096, 3962.5641179470235, 3971.106501037272, 3979.1047014421524, 3981.084350599364, 3527.805970671612, 3532.73904700989, 3534.6642069003406, 3544.326577950181, 3553.6446355364515, 4853.490383509751, 4883.096627123958, 4891.192953162724, 4895.241237608141, 4910.288008238786, 4347.8695639130565, 4561.452625684906, 4587.79354929029, 4591.127685739699, 4605.30920361945, 5270.183121616117, 5334.653247538898, 5351.197320401932, 5371.382291036542, 5380.569554435636, 3889.2804831106337, 3893.260280546687, 3896.5129358830145, 3896.7077469189926, 3903.7852918089493, 5499.092649712793, 5561.749721262553, 5623.569622530254, 5662.094064949588, 5668.688222147822, 3988.222296652183, 4007.6994225432627, 4008.118213992917, 4010.057636455431, 4013.779242141652, 4056.472658554369, 4063.878083657495, 4064.04494943688, 4069.9389509157386, 4075.5313138989395, 4408.338749187584, 4574.656900732459, 4581.0, 4583.083383323348, 4588.311753236974, 5313.362396512443, 5332.573394128461, 5335.33308336458, 5349.277847490539, 5356.3572371315695, 1387.840398354182, 1407.92960351982, 1408.112888879999, 1412.2232771975373, 1416.178616402484, 883.8099808541194, 920.5949382271779, 946.4132238012477, 957.3298690916387, 961.0437614573544, 4601.493835678073, 4605.976970115128, 4610.308453731967, 4626.1441633297945, 4647.767611619405, 5432.130859062531, 5455.235887237873, 5455.509004189642, 5455.781768729285, 5467.917981230285, 4498.977505112453, 4588.678792484494, 4624.745638989888, 4632.745199014019, 4641.118187544355, 2886.8123571967753, 2907.3749143934156, 2910.898118565882, 2918.97081029187, 2936.765058795291, 5138.537531622097, 5140.588752899759, 5145.4597267287145, 5149.536541711264, 5170.5346518813485, 5336.59853066114, 5522.5581953443625, 5557.777688892399, 5562.471565201299, 5568.6658800472105, 5047.823326183566, 5112.642115051911, 5114.974425127851, 5126.333576635014, 5141.434442211354, 5345.024855992921, 5418.187271909245, 5419.214213938878, 5435.864103397446, 5461.890762184814, 5214.713190774392, 5328.17413300939, 5338.1992701093595, 5339.492748188916, 5358.517733403856, 5077.263796749525, 5102.351818449826, 5129.204973229155, 5132.281480592795, 5151.25306830515, 3946.3883098119836, 3953.6441720245316, 3955.723099383131, 3956.3076461619676, 3959.406089086545, 5291.23277124807, 5600.411956744646, 5604.943950560605, 5606.271184745957, 5608.775648973995, 5365.490278423699, 5375.46245375475, 5380.43505431924, 5386.434424385383, 5403.297571315861, 5220.269162317202, 5390.326209223847, 5414.593905457185, 5421.105517589711, 5423.349198096096, 4913.680610760289, 5278.551323137576, 5310.230016647642, 5320.14877619579, 5330.387005494263, 5228.268042474133, 5401.918971215514, 5426.918596220981, 5430.592705547021, 5442.836714898559, 5278.973605132103, 5293.311869456946, 5300.655457395257, 5305.495977882095, 5310.150375939831], "value": 4031.2961097562684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.405307117452, 707.6850801393375, 740.4520654715509, 765.5177238339845, 768.4275214964852, 11525.827112593317, 11543.942280288597, 11546.422678866065, 11570.59502917397, 12223.083268754846, 12570.18293810904, 13254.337283135852, 13280.33598320085, 13297.335133243347, 13313.334333283321, 640.785336912135, 778.6534991928594, 810.5582457560644, 811.9878201826963, 815.1115284340068, 807.1928071928072, 811.3833486550235, 811.4157806379397, 811.930985866202, 812.6261919517029, 842.4481964313385, 844.8521508735977, 845.7462761171655, 847.5338563789891, 847.6524624903791, 669.5647828911198, 826.7354446577098, 835.0271933197818, 837.6523742646795, 845.9280961118312, 618.2426527503817, 618.7865186510646, 618.8731310081467, 620.3269452643842, 621.9471344935686, 11945.223560468628, 11959.0, 12082.15424920256, 12088.697782555419, 12094.455749491293, 11033.944830275797, 11284.943575282154, 11346.751857295774, 11395.829062564067, 11528.193026488148, 9619.56711947964, 10048.296619236657, 10264.281500294983, 10354.17166626668, 10459.84310235347, 3280.0, 3285.6385797562248, 3352.932941341184, 3352.949705754416, 3408.3694516514524, 49907.2513912288, 50263.0, 50273.49726502725, 50306.245406318936, 50442.24336634953, 9660.32377733566, 9683.854742178873, 9774.804503910023, 10068.39589624625, 10098.293119481566, 17441.30234790594, 17463.47609571715, 17487.213075411637, 17489.125543722763, 17539.912300438416, 6687.4984376171005, 6739.460843132538, 6779.186497620317, 6787.796366109024, 6952.513324067267, 3727.4408838674417, 3769.246150769857, 3803.4294855771304, 3805.562360328542, 3810.9809450952566, 2466.3710753757678, 2573.8198326117367, 2575.562154433751, 2576.9613455798176, 2578.4456341886585, 436.2670713201788, 476.7568540044602, 482.2645465664889, 486.88503327380613, 488.78737749079266, 535.8097875254228, 573.6414740787009, 605.2132228103447, 622.4677900395097, 626.9686515674198, 7837.531177679013, 7871.252231038042, 8048.59529233107, 8317.542535160625, 8472.703455379033, 583.8073435766187, 595.7736060297059, 613.6410200033031, 634.3434545245649, 635.5043066408209, 3707.6848467879995, 3720.6093360197333, 3751.1372384351207, 3788.1476667749534, 3819.7899115548357, 45023.774881125384, 46829.76585117052, 46944.061118777434, 54984.725076374365, 56096.43903560994, 41609.37585936213, 42901.0, 43451.56548434538, 43697.78151109224, 44270.77864610721, 36993.0, 40150.79924600358, 40545.0, 40608.79695601562, 40869.79565102155, 7835.529868207926, 8194.918050819415, 8308.875366869623, 8360.038595561346, 8405.0, 28790.856045719636, 29111.272218194714, 29462.558061629523, 29540.96606618758, 31353.37293254168, 42055.57944420516, 42083.579164207964, 42340.0, 42399.0, 43384.13231735411, 11210.383428911162, 11319.830202547133, 11402.144839136932, 11430.314181149157, 11728.648140555797, 11891.464884080064, 12041.0, 12076.51693932233, 12239.265644061385, 12284.754304914031, 9822.950885245527, 10149.34029288094, 10184.745381365525, 10251.58993640246, 10327.431991240554, 9928.751781205528, 10199.490025498844, 10373.63692270797, 10378.896211038094, 10902.127829773757, 10665.41340226295, 10695.304805187638, 11240.83138752903, 11254.268472549258, 11293.43532823372, 9642.807143857224, 9862.260330475387, 9930.702078937355, 9955.303128780915, 10169.593216271267, 9173.862392063991, 9550.808983820423, 9563.330566860253, 9743.951280243553, 9787.755306117118], "value": 5896.2323533956915, "unit": "score"}], "name": "dromaeo_css", "value": 6273.136736834188, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 109.0, 112.0, 114.0, 113.0, 103.0, 113.0, 113.0, 114.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 135.0, 156.0, 191.0, 133.0, 164.0, 165.0, 132.0, 181.0, 133.0], "value": 154.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 162.0, 163.0, 162.0, 162.0, 161.0, 162.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 116.0, 113.0, 78.0, 74.0, 73.0, 112.0, 104.0, 74.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 145.0, 94.0, 93.0, 94.0, 145.0, 94.0, 95.0, 136.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 65.0, 65.0, 64.0, 65.0, 80.0, 62.0, 63.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 79.0, 89.0, 82.0, 89.0, 82.0, 82.0, 81.0, 81.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 131.0, 146.0, 133.0, 134.0, 132.0, 138.0, 167.0, 146.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 179.0, 181.0, 177.0, 183.0, 180.0, 176.0, 175.0, 178.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 73.0, 72.0, 72.0, 73.0, 72.0, 72.0, 72.0, 74.0], "value": 72.8, "unit": "score"}], "name": "kraken", "value": 1588.9999999999998, "alertThreshold": 2.0}]} 17:27:21 INFO - Return code: 0 17:27:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:27:21 ERROR - # TBPL SUCCESS # 17:27:21 INFO - Running post-action listener: _resource_record_post_action 17:27:21 INFO - Running post-run listener: _resource_record_post_run 17:27:23 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 517120000; Read time: 0; Write time: 520064 17:27:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 189825024; Read time: 0; Write time: 201076 17:27:23 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 283164672; Read time: 0; Write time: 304436 17:27:23 INFO - Running post-run listener: _upload_blobber_files 17:27:23 INFO - Blob upload gear active. 17:27:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:27:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:27:23 INFO - (blobuploader) - INFO - Open directory for files ... 17:27:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:27:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:27:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:24 INFO - (blobuploader) - INFO - Done attempting. 17:27:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:27:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:27:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:27:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:27:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:27:25 INFO - (blobuploader) - INFO - Done attempting. 17:27:25 INFO - (blobuploader) - INFO - Iteration through files over. 17:27:25 INFO - Return code: 0 17:27:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:27:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:27:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/881443b4822ed0ceaab84777deb0d3a6063e68a0f08374da5a80992c09d3814e8a801f10dd1bda90efb0e7bd605e12043be8c9fb1a1b11313dec17471086a736", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d66124afc9d55ac2670e77ec7610512778563fec7252936eb0e61744eceb73dacf5db69893a158fbcd599c842a70ae2f80f07023bffddfbb6edf4d423ac95654"} 17:27:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:27:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:27:25 INFO - Contents: 17:27:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/881443b4822ed0ceaab84777deb0d3a6063e68a0f08374da5a80992c09d3814e8a801f10dd1bda90efb0e7bd605e12043be8c9fb1a1b11313dec17471086a736", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d66124afc9d55ac2670e77ec7610512778563fec7252936eb0e61744eceb73dacf5db69893a158fbcd599c842a70ae2f80f07023bffddfbb6edf4d423ac95654"} 17:27:25 INFO - Running post-run listener: copy_logs_to_upload_dir 17:27:25 INFO - Copying logs to upload dir... 17:27:25 INFO - mkdir: /builds/slave/test/build/upload/logs 17:27:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.016673 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-04-18 17:27:24.690293) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 17:27:24.693476) ========= 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=232498196343f89f466a4a9a000001c8-1461024090.849090-678595068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/881443b4822ed0ceaab84777deb0d3a6063e68a0f08374da5a80992c09d3814e8a801f10dd1bda90efb0e7bd605e12043be8c9fb1a1b11313dec17471086a736", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d66124afc9d55ac2670e77ec7610512778563fec7252936eb0e61744eceb73dacf5db69893a158fbcd599c842a70ae2f80f07023bffddfbb6edf4d423ac95654"} build_url:https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/Y8ZtH3_lQAu-dTJfy2alOw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/881443b4822ed0ceaab84777deb0d3a6063e68a0f08374da5a80992c09d3814e8a801f10dd1bda90efb0e7bd605e12043be8c9fb1a1b11313dec17471086a736", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d66124afc9d55ac2670e77ec7610512778563fec7252936eb0e61744eceb73dacf5db69893a158fbcd599c842a70ae2f80f07023bffddfbb6edf4d423ac95654"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-18 17:27:24.721466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:27:24.722270) ========= 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=232498196343f89f466a4a9a000001c8-1461024090.849090-678595068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-18 17:27:24.801684) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 17:27:24.801983) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-18 17:27:24.802263) ========= ========= Total master_lag: 0.16 =========