builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1461607963.27 results: success (0) buildid: 20160425083246 builduid: 50db10e0b6694c7ea7174be0c98346bc revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.273814) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.274557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.274873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.291285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.291554) ========= 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=af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 11:12:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.8M=0s 2016-04-25 11:12:43 (31.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077701 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.382012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.382305) ========= 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=af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014340 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.431330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.431691) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0f07f975526f3abda2f997bbb2feb0a25f771227 --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 0f07f975526f3abda2f997bbb2feb0a25f771227 --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=af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 11:12:43,673 truncating revision to first 12 chars 2016-04-25 11:12:43,673 Setting DEBUG logging. 2016-04-25 11:12:43,673 attempt 1/10 2016-04-25 11:12:43,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0f07f975526f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 11:12:43,934 unpacking tar archive at: fx-team-0f07f975526f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.521402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.967828) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.968352) ========= script_repo_revision: 0f07f975526f3abda2f997bbb2feb0a25f771227 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.969024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.969503) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 11:12:43.981382) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-25 11:12:43.981994) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:44 INFO - MultiFileLogger online at 20160425 11:12:44 in /builds/slave/test 11:12:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:12:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:44 INFO - {'append_to_log': False, 11:12:44 INFO - 'base_work_dir': '/builds/slave/test', 11:12:44 INFO - 'blob_upload_branch': 'Fx-Team', 11:12:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:44 INFO - 'branch': 'Fx-Team', 11:12:44 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:44 INFO - 'config_files': ('talos/linux_config.py',), 11:12:44 INFO - 'default_actions': ('clobber', 11:12:44 INFO - 'read-buildbot-config', 11:12:44 INFO - 'download-and-extract', 11:12:44 INFO - 'populate-webroot', 11:12:44 INFO - 'create-virtualenv', 11:12:44 INFO - 'install', 11:12:44 INFO - 'run-tests'), 11:12:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:44 INFO - 'download_minidump_stackwalk': True, 11:12:44 INFO - 'download_symbols': 'ondemand', 11:12:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:12:44 INFO - 'tooltool.py': '/tools/tooltool.py', 11:12:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:12:44 INFO - '/tools/misc-python/virtualenv.py')}, 11:12:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:44 INFO - 'installer_path': 'installer.exe', 11:12:44 INFO - 'log_level': 'info', 11:12:44 INFO - 'log_name': 'talos', 11:12:44 INFO - 'log_to_console': True, 11:12:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:44 INFO - 'opt_config_files': (), 11:12:44 INFO - 'pip_index': False, 11:12:44 INFO - 'sps_profile': False, 11:12:44 INFO - 'sps_profile_interval': 0, 11:12:44 INFO - 'suite': 'dromaeojs', 11:12:44 INFO - 'system_bits': '32', 11:12:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:44 INFO - 'title': 'talos-linux64-ix-020', 11:12:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:44 INFO - 'use_talos_json': True, 11:12:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:44 INFO - 'work_dir': 'build'} 11:12:44 INFO - ##### 11:12:44 INFO - ##### Running clobber step. 11:12:44 INFO - ##### 11:12:44 INFO - Running pre-action listener: _resource_record_pre_action 11:12:44 INFO - Running main action method: clobber 11:12:44 INFO - rmtree: /builds/slave/test/build 11:12:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:45 INFO - Running post-action listener: _resource_record_post_action 11:12:45 INFO - ##### 11:12:45 INFO - ##### Running read-buildbot-config step. 11:12:45 INFO - ##### 11:12:45 INFO - Running pre-action listener: _resource_record_pre_action 11:12:45 INFO - Running main action method: read_buildbot_config 11:12:45 INFO - Using buildbot properties: 11:12:45 INFO - { 11:12:45 INFO - "project": "", 11:12:45 INFO - "product": "firefox", 11:12:45 INFO - "script_repo_revision": "production", 11:12:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:12:45 INFO - "repository": "", 11:12:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:12:45 INFO - "buildid": "20160425083246", 11:12:45 INFO - "pgo_build": "True", 11:12:45 INFO - "basedir": "/builds/slave/test", 11:12:45 INFO - "buildnumber": 1115, 11:12:45 INFO - "slavename": "talos-linux64-ix-020", 11:12:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:12:45 INFO - "platform": "ubuntu64_hw", 11:12:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:12:45 INFO - "branch": "fx-team", 11:12:45 INFO - "repo_path": "integration/fx-team", 11:12:45 INFO - "revision": "0f07f975526f3abda2f997bbb2feb0a25f771227", 11:12:45 INFO - "stage_platform": "linux64-pgo", 11:12:45 INFO - "builduid": "50db10e0b6694c7ea7174be0c98346bc", 11:12:45 INFO - "slavebuilddir": "test" 11:12:45 INFO - } 11:12:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 11:12:45 INFO - Running post-action listener: _resource_record_post_action 11:12:45 INFO - ##### 11:12:45 INFO - ##### Running download-and-extract step. 11:12:45 INFO - ##### 11:12:45 INFO - Running pre-action listener: _resource_record_pre_action 11:12:45 INFO - Running main action method: download_and_extract 11:12:45 INFO - mkdir: /builds/slave/test/build/tests 11:12: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')]} 11:12:45 INFO - https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:12:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:12:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:12:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:12:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:12:55 INFO - Downloaded 1361 bytes. 11:12:55 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 11:12:55 INFO - Using the following test package requirements: 11:12:55 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:55 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:12:55 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:12:55 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:55 INFO - u'jsshell-linux-x86_64.zip'], 11:12:55 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:12:55 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:55 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:12:55 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:12:55 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:12:55 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:55 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:12:55 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:12: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')]} 11:12:55 INFO - https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:12:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:12:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:12:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:12:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:12:59 INFO - Downloaded 23860530 bytes. 11:12:59 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'] 11:12:59 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 11:13:00 INFO - Return code: 0 11:13:00 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 11:13:00 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')]} 11:13:00 INFO - https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:13:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:13:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 11:13:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:13:02 INFO - Downloaded 23860530 bytes. 11:13:02 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'] 11:13:02 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 11:13:04 INFO - Return code: 0 11:13: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')]} 11:13:04 INFO - https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:13:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:13:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 11:13:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:13:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:13:05 INFO - Downloaded 10840145 bytes. 11:13:05 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'] 11:13:05 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 11:13:05 INFO - Return code: 0 11:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:05 INFO - https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:13:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:13:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:13:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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 11:13:10 INFO - Downloaded 58351858 bytes. 11:13:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:13:10 INFO - mkdir: /builds/slave/test/properties 11:13:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:13:10 INFO - Writing to file /builds/slave/test/properties/build_url 11:13:10 INFO - Contents: 11:13:10 INFO - build_url:https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 11:13:11 INFO - Running post-action listener: _resource_record_post_action 11:13:11 INFO - Running post-action listener: set_extra_try_arguments 11:13:11 INFO - ##### 11:13:11 INFO - ##### Running populate-webroot step. 11:13:11 INFO - ##### 11:13:11 INFO - Running pre-action listener: _resource_record_pre_action 11:13:11 INFO - Running main action method: populate_webroot 11:13:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:13:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:13:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:13:11 INFO - '--tppagecycles', 11:13:11 INFO - '7'], 11:13:11 INFO - 'tests': ['tsvgm']}}, 11:13:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:13:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:13:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:13:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:13:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:11 INFO - 'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:11 INFO - 'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['damp', 'tps']}, 11:13:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:11 INFO - 'tests': ['damp', 'tps']}, 11:13:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['dromaeo_dom']}, 11:13:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['a11yr', 11:13:11 INFO - 'ts_paint', 11:13:11 INFO - 'tpaint', 11:13:11 INFO - 'sessionrestore', 11:13:11 INFO - 'sessionrestore_no_auto_restore', 11:13:11 INFO - 'tabpaint']}, 11:13:11 INFO - 'other-e10s': {'tests': ['a11yr', 11:13:11 INFO - 'ts_paint', 11:13:11 INFO - 'tpaint', 11:13:11 INFO - 'sessionrestore', 11:13:11 INFO - 'sessionrestore_no_auto_restore', 11:13:11 INFO - 'tabpaint']}, 11:13:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:13:11 INFO - 'ts_paint', 11:13:11 INFO - 'tpaint', 11:13:11 INFO - 'sessionrestore', 11:13:11 INFO - 'sessionrestore_no_auto_restore', 11:13:11 INFO - 'tabpaint']}, 11:13:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:13:11 INFO - 'ts_paint', 11:13:11 INFO - 'tpaint', 11:13:11 INFO - 'sessionrestore', 11:13:11 INFO - 'sessionrestore_no_auto_restore', 11:13:11 INFO - 'tabpaint']}, 11:13:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['a11yr', 11:13:11 INFO - 'ts_paint', 11:13:11 INFO - 'tpaint', 11:13:11 INFO - 'sessionrestore', 11:13:11 INFO - 'sessionrestore_no_auto_restore', 11:13:11 INFO - 'tabpaint']}, 11:13:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['a11yr', 11:13:11 INFO - 'ts_paint', 11:13:11 INFO - 'tpaint', 11:13:11 INFO - 'sessionrestore', 11:13:11 INFO - 'sessionrestore_no_auto_restore', 11:13:11 INFO - 'tabpaint']}, 11:13:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['tsvgx', 11:13:11 INFO - 'tsvgr_opacity', 11:13:11 INFO - 'tart', 11:13:11 INFO - 'tscrollx', 11:13:11 INFO - 'cart']}, 11:13:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:13:11 INFO - 'tsvgr_opacity', 11:13:11 INFO - 'tart', 11:13:11 INFO - 'tscrollx', 11:13:11 INFO - 'cart']}, 11:13:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:11 INFO - 'talos_options': ['--disable-e10s'], 11:13:11 INFO - 'tests': ['tp5o']}, 11:13:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:11 INFO - 'tests': ['tp5o']}, 11:13:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:11 INFO - 'talos_options': ['--disable-e10s', 11:13:11 INFO - '--xperf_path', 11:13:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:11 INFO - 'tests': ['tp5n']}, 11:13:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:13:11 INFO - 'talos_options': ['--xperf_path', 11:13:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:11 INFO - 'tests': ['tp5n']}}, 11:13:11 INFO - 'talos.zip': {'path': '', 11:13:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:13:11 INFO - Running post-action listener: _resource_record_post_action 11:13:11 INFO - ##### 11:13:11 INFO - ##### Running create-virtualenv step. 11:13:11 INFO - ##### 11:13:11 INFO - Running pre-action listener: _resource_record_pre_action 11:13:11 INFO - Running main action method: create_virtualenv 11:13:11 INFO - Creating virtualenv /builds/slave/test/build/venv 11:13:11 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 11:13:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:13:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:11 INFO - Using real prefix '/usr' 11:13:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:13:12 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:14 INFO - Installing pip.................done. 11:13:14 INFO - Return code: 0 11:13:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:13:14 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')]} 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:14 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')]} 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:14 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 0x7f56732a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', '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 11:13:14 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 11:13:14 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 11:13:14 INFO - Using env: {'DISPLAY': ':0', 11:13:14 INFO - 'HOME': '/home/cltbld', 11:13:14 INFO - 'LANG': 'en_US.UTF-8', 11:13:14 INFO - 'LANGUAGE': 'en_US:en', 11:13:14 INFO - 'LOGNAME': 'cltbld', 11:13:14 INFO - 'MAIL': '/var/mail/cltbld', 11:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:14 INFO - 'MOZ_NO_REMOTE': '1', 11:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:14 INFO - 'NO_EM_RESTART': '1', 11:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:14 INFO - 'PWD': '/builds/slave/test', 11:13:14 INFO - 'SHELL': '/bin/bash', 11:13:14 INFO - 'SHLVL': '1', 11:13:14 INFO - 'TERM': 'linux', 11:13:14 INFO - 'TMOUT': '86400', 11:13:14 INFO - 'USER': 'cltbld', 11:13:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:14 INFO - '_': '/tools/buildbot/bin/python'} 11:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:14 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 11:13:14 INFO - Cleaning up... 11:13:14 INFO - Return code: 0 11:13:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:13:14 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')]} 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:14 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')]} 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:14 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 0x7f56732a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', '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 11:13:14 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 11:13:14 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 11:13:14 INFO - Using env: {'DISPLAY': ':0', 11:13:14 INFO - 'HOME': '/home/cltbld', 11:13:14 INFO - 'LANG': 'en_US.UTF-8', 11:13:14 INFO - 'LANGUAGE': 'en_US:en', 11:13:14 INFO - 'LOGNAME': 'cltbld', 11:13:14 INFO - 'MAIL': '/var/mail/cltbld', 11:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:14 INFO - 'MOZ_NO_REMOTE': '1', 11:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:14 INFO - 'NO_EM_RESTART': '1', 11:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:14 INFO - 'PWD': '/builds/slave/test', 11:13:14 INFO - 'SHELL': '/bin/bash', 11:13:14 INFO - 'SHLVL': '1', 11:13:14 INFO - 'TERM': 'linux', 11:13:14 INFO - 'TMOUT': '86400', 11:13:14 INFO - 'USER': 'cltbld', 11:13:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:14 INFO - '_': '/tools/buildbot/bin/python'} 11:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:14 INFO - Downloading/unpacking psutil>=0.7.1 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:16 INFO - Installing collected packages: psutil 11:13:16 INFO - Running setup.py install for psutil 11:13:16 INFO - building 'psutil._psutil_linux' extension 11:13:16 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 11:13:16 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 11:13:16 INFO - building 'psutil._psutil_posix' extension 11:13:16 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 11:13:16 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 11:13:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:17 INFO - Successfully installed psutil 11:13:17 INFO - Cleaning up... 11:13:17 INFO - Return code: 0 11:13:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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')]} 11:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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', '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 0x7f56732a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', '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 11:13: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:13: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 mozsystemmonitor==0.0.0 11:13:17 INFO - Using env: {'DISPLAY': ':0', 11:13:17 INFO - 'HOME': '/home/cltbld', 11:13:17 INFO - 'LANG': 'en_US.UTF-8', 11:13:17 INFO - 'LANGUAGE': 'en_US:en', 11:13:17 INFO - 'LOGNAME': 'cltbld', 11:13:17 INFO - 'MAIL': '/var/mail/cltbld', 11:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:17 INFO - 'MOZ_NO_REMOTE': '1', 11:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:17 INFO - 'NO_EM_RESTART': '1', 11:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:17 INFO - 'PWD': '/builds/slave/test', 11:13:17 INFO - 'SHELL': '/bin/bash', 11:13:17 INFO - 'SHLVL': '1', 11:13:17 INFO - 'TERM': 'linux', 11:13:17 INFO - 'TMOUT': '86400', 11:13:17 INFO - 'USER': 'cltbld', 11:13:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:17 INFO - '_': '/tools/buildbot/bin/python'} 11:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:13:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:13:19 INFO - Installing collected packages: mozsystemmonitor 11:13:19 INFO - Running setup.py install for mozsystemmonitor 11:13:19 INFO - Successfully installed mozsystemmonitor 11:13:19 INFO - Cleaning up... 11:13:19 INFO - Return code: 0 11:13:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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')]} 11:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13: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', '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 0x7f56732a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', '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 11:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:13: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 blobuploader==1.2.4 11:13:19 INFO - Using env: {'DISPLAY': ':0', 11:13:19 INFO - 'HOME': '/home/cltbld', 11:13:19 INFO - 'LANG': 'en_US.UTF-8', 11:13:19 INFO - 'LANGUAGE': 'en_US:en', 11:13:19 INFO - 'LOGNAME': 'cltbld', 11:13:19 INFO - 'MAIL': '/var/mail/cltbld', 11:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:19 INFO - 'MOZ_NO_REMOTE': '1', 11:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:19 INFO - 'NO_EM_RESTART': '1', 11:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:19 INFO - 'PWD': '/builds/slave/test', 11:13:19 INFO - 'SHELL': '/bin/bash', 11:13:19 INFO - 'SHLVL': '1', 11:13:19 INFO - 'TERM': 'linux', 11:13:19 INFO - 'TMOUT': '86400', 11:13:19 INFO - 'USER': 'cltbld', 11:13:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:19 INFO - '_': '/tools/buildbot/bin/python'} 11:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13: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 11:13:21 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:21 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 11:13:21 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 11:13:21 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 11:13:21 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 11:13:21 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 11:13:21 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 11:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:21 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 11:13:21 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 11:13:21 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 11:13:21 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 11:13:21 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 11:13:21 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 11:13:22 INFO - Downloading docopt-0.6.1.tar.gz 11:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:22 INFO - Running setup.py install for blobuploader 11:13:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:22 INFO - Running setup.py install for requests 11:13:22 INFO - Running setup.py install for docopt 11:13:22 INFO - Successfully installed blobuploader requests docopt 11:13:22 INFO - Cleaning up... 11:13:22 INFO - Return code: 0 11:13:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:22 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')]} 11:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:22 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')]} 11:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:22 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 0x7f56732a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', '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 11:13:22 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 11:13:22 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 11:13:22 INFO - Using env: {'DISPLAY': ':0', 11:13:22 INFO - 'HOME': '/home/cltbld', 11:13:22 INFO - 'LANG': 'en_US.UTF-8', 11:13:22 INFO - 'LANGUAGE': 'en_US:en', 11:13:22 INFO - 'LOGNAME': 'cltbld', 11:13:22 INFO - 'MAIL': '/var/mail/cltbld', 11:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:22 INFO - 'MOZ_NO_REMOTE': '1', 11:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:22 INFO - 'NO_EM_RESTART': '1', 11:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:22 INFO - 'PWD': '/builds/slave/test', 11:13:22 INFO - 'SHELL': '/bin/bash', 11:13:22 INFO - 'SHLVL': '1', 11:13:22 INFO - 'TERM': 'linux', 11:13:22 INFO - 'TMOUT': '86400', 11:13:22 INFO - 'USER': 'cltbld', 11:13:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:22 INFO - '_': '/tools/buildbot/bin/python'} 11:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:23 INFO - Running setup.py (path:/tmp/pip-Yg68rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:23 INFO - Running setup.py (path:/tmp/pip-ndxt9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:23 INFO - Running setup.py (path:/tmp/pip-Y5h19W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:23 INFO - Running setup.py (path:/tmp/pip-LtHnzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:23 INFO - Running setup.py (path:/tmp/pip-heSq13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:23 INFO - Running setup.py (path:/tmp/pip-HtQVbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:23 INFO - Running setup.py (path:/tmp/pip-MQnfgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:23 INFO - Running setup.py (path:/tmp/pip-U0KNPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:23 INFO - Running setup.py (path:/tmp/pip-VPQZBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:23 INFO - Running setup.py (path:/tmp/pip-r59hDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:23 INFO - Running setup.py (path:/tmp/pip-qmqmCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:23 INFO - Running setup.py (path:/tmp/pip-N7xdSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:23 INFO - Running setup.py (path:/tmp/pip-cBZDRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:23 INFO - Running setup.py (path:/tmp/pip-LKbjZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:24 INFO - Running setup.py (path:/tmp/pip-IiZfKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:24 INFO - Running setup.py (path:/tmp/pip-5iZsiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:24 INFO - Running setup.py (path:/tmp/pip-YSoxpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:24 INFO - Running setup.py install for manifestparser 11:13:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:24 INFO - Running setup.py install for mozcrash 11:13:24 INFO - Running setup.py install for mozdebug 11:13:24 INFO - Running setup.py install for mozdevice 11:13:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:13:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:24 INFO - Running setup.py install for mozfile 11:13:24 INFO - Running setup.py install for mozhttpd 11:13:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:24 INFO - Running setup.py install for mozinfo 11:13:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:24 INFO - Running setup.py install for mozInstall 11:13:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Running setup.py install for mozleak 11:13:25 INFO - Running setup.py install for mozlog 11:13:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Running setup.py install for moznetwork 11:13:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Running setup.py install for mozprocess 11:13:25 INFO - Running setup.py install for mozprofile 11:13:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Running setup.py install for mozrunner 11:13:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:25 INFO - Running setup.py install for mozscreenshot 11:13:25 INFO - Running setup.py install for moztest 11:13:25 INFO - Running setup.py install for mozversion 11:13:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:26 INFO - Cleaning up... 11:13:26 INFO - Return code: 0 11:13:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:26 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')]} 11:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:26 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')]} 11:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:26 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 0x7f56732a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', '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 11:13:26 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 11:13:26 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 11:13:26 INFO - Using env: {'DISPLAY': ':0', 11:13:26 INFO - 'HOME': '/home/cltbld', 11:13:26 INFO - 'LANG': 'en_US.UTF-8', 11:13:26 INFO - 'LANGUAGE': 'en_US:en', 11:13:26 INFO - 'LOGNAME': 'cltbld', 11:13:26 INFO - 'MAIL': '/var/mail/cltbld', 11:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:26 INFO - 'MOZ_NO_REMOTE': '1', 11:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:26 INFO - 'NO_EM_RESTART': '1', 11:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:26 INFO - 'PWD': '/builds/slave/test', 11:13:26 INFO - 'SHELL': '/bin/bash', 11:13:26 INFO - 'SHLVL': '1', 11:13:26 INFO - 'TERM': 'linux', 11:13:26 INFO - 'TMOUT': '86400', 11:13:26 INFO - 'USER': 'cltbld', 11:13:26 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:26 INFO - '_': '/tools/buildbot/bin/python'} 11:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:26 INFO - Running setup.py (path:/tmp/pip-Tyilm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:26 INFO - Running setup.py (path:/tmp/pip-Jz4lCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:26 INFO - Running setup.py (path:/tmp/pip-PFT44b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:26 INFO - Running setup.py (path:/tmp/pip-jyMP1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:26 INFO - Running setup.py (path:/tmp/pip-WEYOy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:26 INFO - Running setup.py (path:/tmp/pip-RGhrpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:26 INFO - Running setup.py (path:/tmp/pip-xzXH3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:26 INFO - Running setup.py (path:/tmp/pip-evSp8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:26 INFO - Running setup.py (path:/tmp/pip-yvtlKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:26 INFO - Running setup.py (path:/tmp/pip-GBmmVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:26 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)) 11:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:26 INFO - Running setup.py (path:/tmp/pip-0YegMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:27 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)) 11:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:27 INFO - Running setup.py (path:/tmp/pip-C9mx17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:27 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)) 11:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:27 INFO - Running setup.py (path:/tmp/pip-IyxrxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:27 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)) 11:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:27 INFO - Running setup.py (path:/tmp/pip-HPCvkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:27 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)) 11:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:27 INFO - Running setup.py (path:/tmp/pip-tyDECw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:27 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)) 11:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:27 INFO - Running setup.py (path:/tmp/pip-vmBv3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:27 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)) 11:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:27 INFO - Running setup.py (path:/tmp/pip-wO5NXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:27 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)) 11:13:27 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)) 11:13:27 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)) 11:13:27 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)) 11:13:27 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)) 11:13:27 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)) 11:13:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:27 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 11:13:27 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 11:13:27 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 11:13:27 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 11:13:27 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 11:13:27 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 11:13:29 INFO - Downloading blessings-1.6.tar.gz 11:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:29 INFO - Installing collected packages: blessings 11:13:29 INFO - Running setup.py install for blessings 11:13:29 INFO - Successfully installed blessings 11:13:29 INFO - Cleaning up... 11:13:29 INFO - Return code: 0 11:13:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:29 INFO - Reading from file tmpfile_stdout 11:13:29 INFO - Current package versions: 11:13:29 INFO - argparse == 1.2.1 11:13:29 INFO - blessings == 1.6 11:13:29 INFO - blobuploader == 1.2.4 11:13:29 INFO - docopt == 0.6.1 11:13:29 INFO - manifestparser == 1.1 11:13:29 INFO - mozInstall == 1.12 11:13:29 INFO - mozcrash == 0.17 11:13:29 INFO - mozdebug == 0.1 11:13:29 INFO - mozdevice == 0.48 11:13:29 INFO - mozfile == 1.2 11:13:29 INFO - mozhttpd == 0.7 11:13:29 INFO - mozinfo == 0.9 11:13:29 INFO - mozleak == 0.1 11:13:29 INFO - mozlog == 3.1 11:13:29 INFO - moznetwork == 0.27 11:13:29 INFO - mozprocess == 0.22 11:13:29 INFO - mozprofile == 0.28 11:13:29 INFO - mozrunner == 6.11 11:13:29 INFO - mozscreenshot == 0.1 11:13:29 INFO - mozsystemmonitor == 0.0 11:13:29 INFO - moztest == 0.7 11:13:29 INFO - mozversion == 1.4 11:13:29 INFO - psutil == 3.1.1 11:13:29 INFO - requests == 1.2.3 11:13:29 INFO - wsgiref == 0.1.2 11:13:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:29 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 0x7f56732a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', '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 11:13:29 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 11:13:29 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 11:13:29 INFO - Using env: {'DISPLAY': ':0', 11:13:29 INFO - 'HOME': '/home/cltbld', 11:13:29 INFO - 'LANG': 'en_US.UTF-8', 11:13:29 INFO - 'LANGUAGE': 'en_US:en', 11:13:29 INFO - 'LOGNAME': 'cltbld', 11:13:29 INFO - 'MAIL': '/var/mail/cltbld', 11:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:29 INFO - 'MOZ_NO_REMOTE': '1', 11:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:29 INFO - 'NO_EM_RESTART': '1', 11:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:29 INFO - 'PWD': '/builds/slave/test', 11:13:29 INFO - 'SHELL': '/bin/bash', 11:13:29 INFO - 'SHLVL': '1', 11:13:29 INFO - 'TERM': 'linux', 11:13:29 INFO - 'TMOUT': '86400', 11:13:29 INFO - 'USER': 'cltbld', 11:13:29 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:29 INFO - '_': '/tools/buildbot/bin/python'} 11:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 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)) 11:13:30 INFO - Cleaning up... 11:13:30 INFO - Return code: 0 11:13:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:30 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 0x7f56732a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', '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 11:13:30 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 11:13:30 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 11:13:30 INFO - Using env: {'DISPLAY': ':0', 11:13:30 INFO - 'HOME': '/home/cltbld', 11:13:30 INFO - 'LANG': 'en_US.UTF-8', 11:13:30 INFO - 'LANGUAGE': 'en_US:en', 11:13:30 INFO - 'LOGNAME': 'cltbld', 11:13:30 INFO - 'MAIL': '/var/mail/cltbld', 11:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:30 INFO - 'MOZ_NO_REMOTE': '1', 11:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:30 INFO - 'NO_EM_RESTART': '1', 11:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:30 INFO - 'PWD': '/builds/slave/test', 11:13:30 INFO - 'SHELL': '/bin/bash', 11:13:30 INFO - 'SHLVL': '1', 11:13:30 INFO - 'TERM': 'linux', 11:13:30 INFO - 'TMOUT': '86400', 11:13:30 INFO - 'USER': 'cltbld', 11:13:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:30 INFO - '_': '/tools/buildbot/bin/python'} 11:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:30 INFO - Downloading/unpacking jsonschema 11:13:30 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 11:13:30 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 11:13:30 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 11:13:30 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 11:13:30 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 11:13:30 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 11:13:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:32 INFO - Downloading/unpacking functools32 (from jsonschema) 11:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:32 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:32 INFO - warning: no files found matching '*.txt' 11:13:32 INFO - no previously-included directories found matching 'build' 11:13:32 INFO - no previously-included directories found matching 'dist' 11:13:32 INFO - no previously-included directories found matching '.git*' 11:13:32 INFO - Installing collected packages: jsonschema, functools32 11:13:32 INFO - Running setup.py install for functools32 11:13:32 INFO - warning: no files found matching '*.txt' 11:13:32 INFO - no previously-included directories found matching 'build' 11:13:32 INFO - no previously-included directories found matching 'dist' 11:13:32 INFO - no previously-included directories found matching '.git*' 11:13:32 INFO - Successfully installed jsonschema functools32 11:13:32 INFO - Cleaning up... 11:13:32 INFO - Return code: 0 11:13:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:32 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 0x7f56732a7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, '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': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', '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 11:13:32 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 11:13:32 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 11:13:32 INFO - Using env: {'DISPLAY': ':0', 11:13:32 INFO - 'HOME': '/home/cltbld', 11:13:32 INFO - 'LANG': 'en_US.UTF-8', 11:13:32 INFO - 'LANGUAGE': 'en_US:en', 11:13:32 INFO - 'LOGNAME': 'cltbld', 11:13:32 INFO - 'MAIL': '/var/mail/cltbld', 11:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:32 INFO - 'MOZ_NO_REMOTE': '1', 11:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:32 INFO - 'NO_EM_RESTART': '1', 11:13:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:32 INFO - 'PWD': '/builds/slave/test', 11:13:32 INFO - 'SHELL': '/bin/bash', 11:13:32 INFO - 'SHLVL': '1', 11:13:32 INFO - 'TERM': 'linux', 11:13:32 INFO - 'TMOUT': '86400', 11:13:32 INFO - 'USER': 'cltbld', 11:13:32 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:32 INFO - '_': '/tools/buildbot/bin/python'} 11:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:32 INFO - Downloading/unpacking flake8 11:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:13:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:13:34 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 11:13:34 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 11:13:34 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 11:13:34 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 11:13:34 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 11:13:34 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 11:13:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:13:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:13:34 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 11:13:34 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 11:13:34 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 11:13:34 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 11:13:34 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 11:13:34 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 11:13:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:13:35 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 11:13:35 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 11:13:35 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 11:13:35 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 11:13:35 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 11:13:35 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 11:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:13:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:35 INFO - no previously-included directories found matching 'docs/_build' 11:13:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:13:35 INFO - Running setup.py install for pep8 11:13:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:13:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:13:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:13:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:13:35 INFO - no previously-included directories found matching 'docs/_build' 11:13:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:13:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:13:35 INFO - Cleaning up... 11:13:35 INFO - Return code: 0 11:13:35 INFO - Running post-action listener: _resource_record_post_action 11:13:35 INFO - Running post-action listener: _start_resource_monitoring 11:13:35 INFO - Starting resource monitoring. 11:13:35 INFO - ##### 11:13:35 INFO - ##### Running install step. 11:13:35 INFO - ##### 11:13:35 INFO - Running pre-action listener: _resource_record_pre_action 11:13:35 INFO - Running main action method: install 11:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:35 INFO - Reading from file tmpfile_stdout 11:13:35 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:36 INFO - Reading from file tmpfile_stdout 11:13:36 INFO - Output received: 11:13:36 INFO - Usage: mozinstall [options] installer 11:13:36 INFO - Options: 11:13:36 INFO - -h, --help show this help message and exit 11:13:36 INFO - -d DEST, --destination=DEST 11:13:36 INFO - Directory to install application into. [default: 11:13:36 INFO - "/builds/slave/test"] 11:13:36 INFO - --app=APP Application being installed. [default: firefox] 11:13:36 INFO - mkdir: /builds/slave/test/build/application 11:13:36 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'] 11:13:36 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 11:13:52 INFO - Reading from file tmpfile_stdout 11:13:52 INFO - Output received: 11:13:52 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:52 INFO - Running post-action listener: _resource_record_post_action 11:13:52 INFO - ##### 11:13:52 INFO - ##### Running run-tests step. 11:13:52 INFO - ##### 11:13:52 INFO - Running pre-action listener: _resource_record_pre_action 11:13:52 INFO - Running main action method: run_tests 11:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:52 INFO - Python 2.7.3 11:13:52 INFO - Return code: 0 11:13:52 INFO - grabbing minidump binary from tooltool 11:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:13:52 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 0x18da810>, '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 0x18db710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18dbba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:52 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 11:13:52 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 11:13:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:52 INFO - Return code: 0 11:13:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:13:53 INFO - Return code: 0 11:13:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 11:13:53 INFO - Using env: {'DISPLAY': ':0', 11:13:53 INFO - 'HOME': '/home/cltbld', 11:13:53 INFO - 'LANG': 'en_US.UTF-8', 11:13:53 INFO - 'LANGUAGE': 'en_US:en', 11:13:53 INFO - 'LOGNAME': 'cltbld', 11:13:53 INFO - 'MAIL': '/var/mail/cltbld', 11:13:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:53 INFO - 'MOZ_NO_REMOTE': '1', 11:13:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:53 INFO - 'NO_EM_RESTART': '1', 11:13:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:53 INFO - 'PWD': '/builds/slave/test', 11:13:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:53 INFO - 'SHELL': '/bin/bash', 11:13:53 INFO - 'SHLVL': '1', 11:13:53 INFO - 'TERM': 'linux', 11:13:53 INFO - 'TMOUT': '86400', 11:13:53 INFO - 'USER': 'cltbld', 11:13:53 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397', 11:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:53 INFO - '_': '/tools/buildbot/bin/python'} 11:13:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 11:13:53 INFO - mozversion application_buildid: 20160425083246 11:13:53 INFO - mozversion application_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 11:13:53 INFO - mozversion application_display_name: Nightly 11:13:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:53 INFO - mozversion application_name: Firefox 11:13:53 INFO - mozversion application_remotingname: firefox 11:13:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:13:53 INFO - mozversion application_vendor: Mozilla 11:13:53 INFO - mozversion application_version: 48.0a1 11:13:53 INFO - mozversion platform_buildid: 20160425083246 11:13:53 INFO - mozversion platform_changeset: 0f07f975526f3abda2f997bbb2feb0a25f771227 11:13:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:13:53 INFO - mozversion platform_version: 48.0a1 11:13:53 INFO - using testdate: 1461608033 11:13:53 INFO - actual date: 1461608033 11:13:53 INFO - starting webserver on 'localhost:47713' 11:13:53 INFO - SUITE-START | Running 2 tests 11:13:53 INFO - TEST-START | dromaeo_css 11:13:53 INFO - operating with platform_type : linux_ 11:13:53 INFO - Initialising browser for dromaeo_css test... 11:13:53 INFO - TEST-INFO | started process 17648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpavHUvH/profile http://localhost:47713/getInfo.html) 11:13:59 INFO - PROCESS | 17648 | __metrics Screen width/height:1600/1200 11:13:59 INFO - PROCESS | 17648 | colorDepth:24 11:13:59 INFO - PROCESS | 17648 | Browser inner width/height: 1024/697 11:13:59 INFO - PROCESS | 17648 | __metrics 11:14:00 ERROR - PROCESS | 17648 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:14:01 INFO - TEST-INFO | 17648: exit 0 11:14:01 INFO - Browser initialized. 11:14:01 INFO - Running cycle 1/1 for dromaeo_css test... 11:14:01 INFO - TEST-INFO | started process 17730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpavHUvH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:12 INFO - PROCESS | 17730 | RSS: Main: 154492928 11:14:12 INFO - PROCESS | 17730 | 11:15:04 INFO - PROCESS | 17730 | 1461608104066 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] 11:17:11 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:47713/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47713/tests/dromaeo/cssquery-ext.html) 11:17:12 INFO - PROCESS | 17730 | RSS: Main: 241082368 11:17:12 INFO - PROCESS | 17730 | 11:20:15 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:47713/tests/dromaeo/cssquery-ext.html (next: http://localhost:47713/tests/dromaeo/cssquery-jquery.html) 11:20:15 INFO - PROCESS | 17730 | RSS: Main: 246505472 11:20:15 INFO - PROCESS | 17730 | 11:23:17 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:47713/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47713/tests/dromaeo/cssquery-mootools.html) 11:23:17 INFO - PROCESS | 17730 | RSS: Main: 245813248 11:23:17 INFO - PROCESS | 17730 | 11:26:19 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:47713/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47713/tests/dromaeo/cssquery-prototype.html) 11:26:20 INFO - PROCESS | 17730 | RSS: Main: 237395968 11:26:20 INFO - PROCESS | 17730 | 11:29:23 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:47713/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47713/tests/dromaeo/cssquery-yui.html) 11:29:23 INFO - PROCESS | 17730 | RSS: Main: 208375808 11:29:23 INFO - PROCESS | 17730 | 11:32:26 INFO - PROCESS | 17730 | Cycle 1(1): loaded http://localhost:47713/tests/dromaeo/cssquery-yui.html (next: http://localhost:47713/tests/dromaeo/cssquery-dojo.html) 11:32:26 INFO - PROCESS | 17730 | RSS: Main: 281321472 11:32:26 INFO - PROCESS | 17730 | 11:32:26 INFO - PROCESS | 17730 | __start_tp_report 11:32:26 INFO - PROCESS | 17730 | _x_x_mozilla_page_load 11:32:26 INFO - PROCESS | 17730 | _x_x_mozilla_page_load_details 11:32:26 INFO - PROCESS | 17730 | |i|pagename|runs| 11:32:26 INFO - PROCESS | 17730 | |0;dojo.html;3113.3306339137084;3141.921451963702;3184.5860038195033;3193.9520907186397;3223.806571605704;5230.074665740581;5236.921446178301;5296.576273898088;5325.760340784665;5349.22436246744;5277.182036784295;5320.361556613212;5408.188771684249;5418.106012507931;5458.863528411782;4778.044391121781;4778.1638213312535;4787.425508938933;4792.520747925215;4940.654154209206;4865.48912364202;4923.507649235065;4934.358533390654;4949.430815456215;4957.132501812169;4730.101280756662;4807.254875494269;4846.39420072491;4872.027157519577;4932.284818701304;4881.389826271716;4900.607951363918;4906.337644417994;4910.140725373081;4954.182559877616;4862.927056094161;4875.804967801284;4878.292647566083;4893.266010098479;4909.361782968192;5216.973915130438;5264.315638966948;5307.389650190239;5345.866353341197;5350.732463376816;5691.317041954951;5695.971520142372;5711.8000869969765;5715.1713001614535;5716.742746576372;5724.198612194296;5755.194272801811;5755.366909639936;5755.942440575583;5759;5178.741062946838;5315.574754019708;5369.5167434931045;5376.301080859464;5379.838604841861;5927.022041363213;5935.406459354116;5935.406459354116;5941.049432090845;5959.314678811906;5494.066008778517;5685.374608793029;5687.374388817227;5692.800751973744;5699.857503562361;5627;5651;5665.065264231438;5699.487046165865;5715.057015592464;5690.2033715279895;5700.714964251771;5703.7148142592705;5704.743286552032;5705.400932902068;5606.439356064361;5680.488756011979;5688.260526131577;5696.145578163226;5709.743061562157;4258.1057977825;4277.272863613193;4318.784060796947;4320.913581728348;4322.956770432255;3826.7321287510163;3827.1771569112775;3836.5779764225913;3865.5747867734526;3879.3017256893468;5211.973940130351;5301.469853014668;5327.0411325961695;5343.358796944314;5350.250964864922;5674.460926212003;5699.800506982236;5702;5717.714114294268;5745.540356771448;5335.226392173191;5343.625946183807;5344.064788661969;5347.144456886879;5352.919706204332;4692.976535117371;4756.548127927841;4757.643176761688;4800.759962001886;4813.807447702053;5866.442687944724;5880.206172166702;5892.351841297454;5900.734466948998;5925.851853703692;5712.057510510802;5732.971335143297;5739.971300143639;5757;5770.451807078321;5597.776088956559;5857;5885.764569417175;5959.344472107978;5959.880802384015;5664.461876121762;5679.574031947538;5696.857578560403;5698.601097923106;5699.658020518782;5741.25363702716;5741.569382296261;5791.681457519709;5793.333766616893;5802.622829516068;5352.170413585901;5558.138488534284;5605.971970140124;5619.8595035124445;5647.604667673388;5569.610127291051;5597.692126933058;5601.187827765033;5607.046802043581;5609.24275222856;5256.868578285421;5477.643953143033;5499;5536.975659503005;5582.5533957282505;5589.608727389206;5650.152477128464;5656.123300888369;5656.377798442086;5676.5742569308295;5468.398476167539;5477.561795056466;5487.067198576331;5489.533389661923;5524.779008839601 11:32:26 INFO - PROCESS | 17730 | |1;ext.html;620.4106099205754;654.2214764430328;654.70538257784;656.9080328753976;661.0976017735792;35391.11522211943;37010;37017.629823701755;37148.07129821759;37176.44235336472;44392.778036109856;45116.54883451165;45117;45118.54881451184;45329.32006019913;8746.868796968034;8912.24245939096;8944.060873608276;8953;8958.641654333818;8834.911650883505;8978.23684986777;8986.910130898705;8989.146031127066;8995.235404990584;8956.149165829236;9030.954845225764;9045.502497362642;9046.3667543272;9049.185573298402;8935.955320223422;9023.639054437816;9024.909750902472;9043.366964312534;9047.366684332099;8731;8797.824043519095;8854.380193386465;8864.024957254696;8872.46765194084;40616;40887.182256355;41148.38277425841;41170.794146029075;41199.7940010301;3352.664733526652;3363.3105213431186;3403.6596340366013;3527.1887465882733;3568.125809176742;29040.41919161626;29949.85025074861;30095.247618809484;30119.548206776915;30388;4210.5578914214175;4245.341971994346;4249.107687385653;4318.740875547446;4336.7831608419765;321552;323259.38370308233;324810;325399;325566;45912.5408745915;50724.492755072715;57826.42173578295;58027.70986145042;58383.41616583865;53880.46119538833;54492.455075448735;54514;54522;54567.45432545624;15768.369265229492;15935.362585496681;15939;15957.840421595867;15960.680786384208;11464.025557827512;12134;12423.44094515749;12935.741285174245;13013.739725205443;18314.175862085973;18318.542036449195;18401.90799045996;18450.723239151423;18536.44390668282;7112.92887071133;7198.58847286165;7264.128304603376;7286.23494533077;7405.44459165554;1012.7084988085666;1132.4677401621225;1149.2242736153064;1149.3793351590048;1168.8480497535265;32442.513362299585;32562;32663.510047349308;32852;32983.83508082492;1110.4447776111945;1160.930344179352;1167.416291854073;1184.644606618011;1219.9268043917393;16836.32654693823;17311.94082071265;17370.913145434446;17397.955357812585;17403.47789566315;488066;493790;494779;496006;496493;55700.44299556952;56235.71882140645;56421.71789141028;56556;56601.43398566044;1307.843058832946;1317.8748018938186;1342.5703774791973;1405.3465138710549;1446.8263808342856;28178.85910570434;28923.566146507397;29247.268818279714;29579;29713.851430742707;40729.59270407258;41150.79424602858;41216.175676485705;41216.79391603143;41230.793846031775;223630;228714;229273;229317;229383;23096.769032310134;23689.881550592138;25095.372615684755;25556.488870222118;25957.87021064958;40737.79631101825;40830;41407.585924141575;41632.167356653306;42566.574334256264;34673.30653386968;35415.11462213465;35448;35730.821345893106;36013.63986360103;35452.64547354596;35957.1010724734;36314.63685363113;36447.81776091208;37351;38211.23577528489;39388.60611393849;39887;40094.599054009086;40125.59874401218;33038;34439;34675.306493870485;34959.475607866414;35125.473117902744;26754.331141721614;26850.865745671148;27051.86474067696;27265;27324.316892077855 11:32:26 INFO - PROCESS | 17730 | |2;jquery.html;392.46428624926966;396.5756640394777;400.2335527464905;401.61445012787726;413.87790601772474;17078.146092695348;17686.204120814564;18145.63708725825;18156.092195390243;18315.725264121033;17557.122143892786;18417.723734143965;18524.72212916804;18695.90652046738;19165.42503724887;5659.8585035374035;5807.680577568232;5842.32813226478;6975.128108986377;7377.299156580117;7297.562146271214;7301.598412087333;7330.230325815793;7354.227806080365;7359.153697324796;7018.89471657923;7379.151397589266;7386.335229829314;7386.889196662054;7392.741254056109;6744.9325506745045;7039.718411263543;7095.04216930718;7290.307420795016;7352.154502232232;6784.151981002375;6812.080369150151;6814.931850681479;6861.4853885958755;6866;24691.62962555563;25483.745162548323;25511;25533.10634127815;26066.609000865003;2380.0479808076734;2454.374134595667;2508.435601989556;2730.426610411816;2964.199666090165;14610.634734131625;14934.402623895032;15055.397784088733;15413.075215486995;16293.755593666105;1969.241841890868;2046.467918341227;2051.8974051297378;2089.5507465894752;2099.8950052497466;90428.54785726029;92147.53926230325;93128;93635;94101.99999999932;17031.318747250218;17599.472015839547;18114.909425452788;18642.81357186438;18842.15210315539;30835.84582077075;31876.840615796773;32077.754557180775;32112.678873211436;32115;9513.286503512265;9755.9024409755;9759.658411955548;9807.656732014346;9839.606415743434;8051.798705032421;8124.512529248264;8141.267285944294;8251.504909705436;8313.459625124347;8610.182032706884;8670.82658346842;8825.117488251251;8870.112988701207;9017.864732029026;3264.5919260092487;3273.463066123773;3413.846376913045;3448.9643124532067;3546.2225776170712;923.5059243304934;1031.742064483879;1063.6277302944063;1110.7056629993058;1122.4499995002552;18070.277188912296;18226.45320640383;18611.441656750318;19697.310594129423;19780;995.2585323933715;1006.1900170362928;1019.3323373190572;1023.4626820919077;1037.4657051618422;10315.27793054479;10722.195835312383;10769.138468922467;10817.350958942488;10850.891491085145;426444;433954;434810;439327;442738;84824;88859;89182.55408723044;89213.10786892047;89525;1014.2393205096178;1014.4724743133529;1039.6257347354795;1041.9687409377732;1046.0376453662648;16464.176791160153;16696.582585435463;17075.65848683044;17079.829201707824;17222.569435764206;37907;38074;38308.23383532369;39381.60618393894;40183.59816401799;53053.20420193623;54382.456175437736;54631.453685462635;54677.72661136669;54908.725456372464;8420.536870472182;8673.132686731276;8715.825683486422;8764.255038321815;8806.119388061143;11980.700482488008;12712.555060572835;13310.201387916368;13363.1313964592;13393.397297121848;5701.714914254354;9309.069093090637;10214.285000050222;11516.654500364668;11875.406229688653;10316.17470602365;10495.947520262655;10612.363258204532;10614.946925265323;10615.203859710708;6586.538942274186;8364.289035432057;11234.269772464764;11891.10816688769;12047.819282710941;8090.11008789021;8126.390520710852;8174.569450346046;8200.0979892213;8253.133420990709;8240;11026.503807328529;11999.820002699791;12202.694932626755;12237.510499579917 11:32:26 INFO - PROCESS | 17730 | |3;mootools.html;1300.655326338521;1486.5614643680117;1517.2034681792059;1644.6464010237796;1771.7165253559424;7866.881996770046;8145.144759800224;8151.307138893194;8175.591220438969;8177.304929081035;7927.326177274924;8104.230098140667;8125.75622731319;8127.796805079876;8135.186481351861;1941.5437372217518;2174.8586341887726;2255.210676263311;2317.8261630377706;2355.634876594122;2244.2145249162827;2255.1768604459335;2256.4584499720113;2257.8758168300737;2258.9435264118365;2259.6610508423705;2315.7221133463922;2329.5457385809773;2335.0309621507054;2335.824813139013;2007.3275452723356;2119.07820098257;2172.576347612216;2176.4667656424117;2182.84720069596;2235.7317121945307;2250.9887450562805;2252.8986195621237;2260.762619924917;2281.4638559938403;8075.596220188967;8103.635336409876;8142.185781421869;8150.959245203795;8165.3059489943425;4799.112164249625;5046.419661738911;5086.643934924557;5099.872503187413;5124.769385377667;3149.5118256670253;3150.4644210484043;3241.3679332530164;3284.753643476749;3329.334133173351;1059.9417032063234;1071.8231491803842;1075.349338764992;1100.114407901639;1191.6365508519898;11264.267822591506;11297.152713546517;11324.6036388726;11328.603498877499;11330.603428880033;4443.4445694288215;4502.099580083931;4575.107853968444;4594.494605593382;4601.953980460219;9584;9587.760305992406;9597.664081757104;9598.280128990353;9600.135987760996;4544.818207271672;5029.2958985742025;5041.092603331435;5059.519345662156;5060.5698515625845;4583.427071616048;4661.557152070548;4666.300054991711;4680.4149481314835;4692.976535117303;3794.734368594172;3847.9807600962376;3909.3354129798004;3930.0960779020415;3946.4080387941463;1228.7051107734258;1245.7570773699042;1249.2067537113999;1256.5602039286177;1256.9308688022247;788.4874831359662;812.118851046621;898.8382091223642;934.0239449775002;982.5774916785708;5465.808696695596;5506.339239291311;5570.136628822539;5678;5705.857353566111;971.9271054670928;987.2792861211356;987.683941138843;988.6836212412103;1009.8384258518602;3865.1303456722576;3936.8031598419966;3950.506186726659;3955.268275369066;3999.140184860269;9564.66523671668;10111.544980475895;10148.949255253825;10243.180545556337;10255.487225638688;10114.634524339268;10114.848277275847;10216.846747298796;10301.021402966706;10326.122279606167;7439.958405823189;7484.738034168778;7611.923880761232;7666.769996900102;7738.535687858746;5660.433956604306;5676.77292908279;5789.797357092481;5817.70911454434;5936.614120082181;9194.862077068716;9581.808363832824;9583.520823958635;9629.759256018655;9720.951395242979;9453.810923781624;9656.27577931672;9674.516274186122;9699.418034917928;9823.066808653166;6599.505037122139;6735.562188457735;7158.46311526648;7226.566406015656;7317.12194536659;7869.291763741291;7912.643931023233;7934.722284720007;7935.365170786438;7963.761087167394;6889;7105.857882842418;7123.82190445243;7195.8560828784175;7212.386947109345;6931.514793964374;6998.195207551197;7068.363847253772;7110.040144580622;7156.141263048467;6269.341719119427;6385.553011289165;6410.4871610272;6437.549371544134;6466.935330646634;4849.684770489906;4904.068227036994;4930.457649658463;4950.084234416644;5003.474635163256;4936.827211047596;4967.627427942846;4986.451490336132;5003.399592048978;5040.949590504048 11:32:26 INFO - PROCESS | 17730 | |4;prototype.html;326.564037010591;332.04868053028065;332.0784822118621;332.55437713463954;334.0379706445437;5206.687598744078;5277.604179686529;5280.2343660169345;5295.682259064449;5308.522917489041;5234.842954711365;5240.397354304256;5255.316808814849;5261.289725887004;5274.367075950881;3898.9805050974705;3920.2551515212017;4046.150308435232;4049.250888585621;4119.876403707878;4096.446979657738;4107.301758701028;4115.629593336599;4141.378793181017;4146.108586653869;3918.941215881764;4084.816183271745;4098.569650186732;4102.384642303663;4108.198901214264;3956.901077473072;4051.6021972419467;4060.2488539620117;4062.939055914164;4094.754314741095;3539.6991255743037;3606.0804494853905;3613.0967258185456;3613.2773445311045;3622.094476380905;4953.23224900141;4995.475475075137;5019.498050194988;5038.874028149289;5050.671706339113;4559.954400456019;4688.789004494806;4691.132140554008;4701.623870090384;4702.858914232578;5333.893322133536;5403.648762830443;5404.648697834628;5413.702246376448;5424.701641409721;3948.940765888514;3980.920381592352;3984.183242435294;4001.379786133154;4002.939955900664;5496.148097044925;5645.689487078209;5655.575831812631;5658.359075867993;5690.9837785973505;4050.1697152083752;4057.6753859691153;4075.694322925792;4085.4893138357706;4100.753954762724;4088.897777555585;4126.236646220459;4138.730982486129;4151.667866570667;4153.1070819773895;4468.553144685506;4637.86086417408;4641.118187544355;4651.720896746206;4671.346011558385;5400.135978243541;5443.836684899459;5455.563554915677;5486.753096110685;5513.365962914316;1492.7462331403688;1499.4526997645999;1499.5801175670829;1507.5778781941074;1507.8416766239386;950.8098380323963;960.5725452173716;976.1263669016191;1020.1023099672241;1039.6413237433073;5448.809291674773;5477.780888764405;5519.199716041152;5536.806211782568;5538.833834984957;5891.558133140032;5921.3782552831335;5922.460160358338;5923.585349025613;5925.970370148121;5328.92006619901;5492.670439773627;5516.365617953907;5532.5020748132865;5552.223288547626;3095.8916437924563;3106.3010822565193;3120.2979329651102;3128.1710346758127;3133.827639479805;5912.08362703773;6005.879882402415;6018.849528761816;6023.126646636213;6041.758329666852;5962.612430192024;5980.491658209014;5993.700314984233;6004.939950600438;6012.518998480111;5985.25921299188;5988.850278742979;6003.309619393825;6017.518598512109;6068.150458935841;5762.962666720031;5773.364929857628;5857.297124345106;5876.236089308533;5914.290285165807;5810.883782324415;5819;5826.592138550261;5828.125781132864;5847.853803654943;5511.669299842022;6020.969895150496;6039.879202415839;6048.425399587032;6058.666773327333;3921.254961557295;3979.4826672532386;3985.8405663773124;3996.1608062306077;4001.039750459927;5599.920043975879;5656;5657.632253903483;5664.951983882995;5689.544836412994;5377.354717433933;5477.67133971947;5490.835274941598;5546.389897111234;5576.275084239023;5162.870928226825;5300.734963251745;5510.669359838423;5514.834554963358;5524.226608274765;5389.487998640123;5428.348598168245;5439.537639300704;5450;5461.371942226695;5305.991861546294;5534.667919924817;5559.664940724824;5560.638558493685;5561.304836895388;5354.4110147884485;5382.281947616429;5390.328998010629;5395.271638328775;5434.891302173855 11:32:26 INFO - PROCESS | 17730 | |5;yui.html;812.1147948735877;850.5449584472309;851.293426456042;870.7083127152404;872.5593575244501;13674;14009.229492377941;14019.85980140197;14058.086224395433;14105.365258563364;11136.443177841116;13080.934595327033;13189.670258243525;13197.802032969514;13200.207987520755;805.4241217529479;832.1803024021334;833.6248688090353;835.2900034970287;836.640244694781;823.3989187892842;829.1915382502073;829.9170082991683;830.0703212402118;831.6590198018813;707.7027648387664;875.9430637008605;877.7542288159326;877.7673916412156;877.9780505487382;843.4686147726924;877.7849426890389;878.3061381508633;878.3324673248313;878.44218920985;623.2365352443267;623.6569886562372;625.5808608232495;625.7403177681302;626.361111666098;13238.66903327415;13259.602211933561;13264.071514993955;13282.73434531304;13284.933575332157;12062.45718942641;12913.289769062698;13539;13662.385192666354;13724.313784310745;12137.211081279776;12379.319137447437;12395.75208495834;12403.875961240363;12427.502899883993;4485.9551404485865;4490.124425736983;4522.977385113087;4542.977285113553;4586.036932244233;49091.263631045564;49338.259926101135;50258;50394.24408633837;50481.24278135831;10614.469276536141;10739.946300268604;10876.836847447295;10962.890371096346;11010.614628487965;18213.180406881722;18294.451166465027;18405.63188736218;18426.539336516693;18446.90776546109;8142.51144931306;8474.703385381605;8503.659853605786;8523;8735.825283494421;4535.006895448988;4563.315502674559;4585.816567337336;4618.884527886763;4709.364235828188;3309.305045940331;3371.561696979426;3380.0197942596374;3388.525606415104;3527.453244747017;579.3135134865198;598.2193237824681;612.091044798474;612.2928018139056;676.8815457295052;587.7325816753367;651.1144843013592;706.5513398991677;730.5073796153697;758.3819187362282;9072.364934454525;9725.124738773544;9790.608375664893;9803;9806.362586431858;740.3268612934806;755.6070843161525;757.9772606821804;780.0717146595533;781.2617076862424;4183.937629999855;4295.871123866289;4389;4446.110777844444;4479.70881892676;67028;67192.6640366795;68264.65867670729;68428.55214411048;69080.58217962347;40923;42755.57244427578;56228.437715623135;57033.714831426405;59838;51510;52506.737466313185;54487.182692259645;54842.451575483734;56140.71929640326;8848.292136629183;8898.11018898105;8910.376273660782;8918.286537076889;8918.554072296489;33869.661303387635;34075.829620851735;34681.65318346784;35203;35276.82361588176;47517.76241118772;48905.755471222416;48961.51038489712;49094.509054908995;49279.753601231765;11627.360495172847;11630.53477860876;11754.353510556659;11800;12048;11216.943915280372;11811.350375729417;11999.940000299943;12174.57388991381;12704.36478176106;11324.886751132713;11545.826812597987;11749.941250294036;11805.23265987708;11877.22798018126;11534.826977595176;11557.190996630155;11699.707507312385;11794.056475482112;11846.170768046153;10341.391474181313;10379.169666426516;10925.180611454332;11263.436828158723;11519.596814111466;9914.702558923243;10095.697129086138;10102;10142.746431338981;10558.10256128207;9986.900130998887;10068.345557538736;10074.19406447497;10094.899051009395;10162.593496260362 11:32:26 INFO - PROCESS | 17730 | __end_tp_report 11:32:26 INFO - PROCESS | 17730 | __start_cc_report 11:32:26 INFO - PROCESS | 17730 | _x_x_mozilla_cycle_collect,785 11:32:26 INFO - PROCESS | 17730 | __end_cc_report 11:32:26 INFO - PROCESS | 17730 | __startTimestamp1461609146430__endTimestamp 11:32:26 INFO - PROCESS | 17730 | 11:32:26 INFO - PROCESS | 17730 | ------- Summary: start ------- 11:32:26 INFO - PROCESS | 17730 | Number of tests: 6 11:32:26 INFO - PROCESS | 17730 | 11:32:26 INFO - PROCESS | 17730 | [#0] dojo.html Cycles:165 Average:5300.18 Median:5494.07 stddev:605.15 (11.0%) stddev-sans-first:582.18 11:32:26 INFO - PROCESS | 17730 | Values: 3113.3 3141.9 3184.6 3194.0 3223.8 5230.1 5236.9 5296.6 5325.8 5349.2 5277.2 5320.4 5408.2 5418.1 5458.9 4778.0 4778.2 4787.4 4792.5 4940.7 4865.5 4923.5 4934.4 4949.4 4957.1 4730.1 4807.3 4846.4 4872.0 4932.3 4881.4 4900.6 4906.3 4910.1 4954.2 4862.9 4875.8 4878.3 4893.3 4909.4 5217.0 5264.3 5307.4 5345.9 5350.7 5691.3 5696.0 5711.8 5715.2 5716.7 5724.2 5755.2 5755.4 5755.9 5759.0 5178.7 5315.6 5369.5 5376.3 5379.8 5927.0 5935.4 5935.4 5941.0 5959.3 5494.1 5685.4 5687.4 5692.8 5699.9 5627.0 5651.0 5665.1 5699.5 5715.1 5690.2 5700.7 5703.7 5704.7 5705.4 5606.4 5680.5 5688.3 5696.1 5709.7 4258.1 4277.3 4318.8 4320.9 4323.0 3826.7 3827.2 3836.6 3865.6 3879.3 5212.0 5301.5 5327.0 5343.4 5350.3 5674.5 5699.8 5702.0 5717.7 5745.5 5335.2 5343.6 5344.1 5347.1 5352.9 4693.0 4756.5 4757.6 4800.8 4813.8 5866.4 5880.2 5892.4 5900.7 5925.9 5712.1 5733.0 5740.0 5757.0 5770.5 5597.8 5857.0 5885.8 5959.3 5959.9 5664.5 5679.6 5696.9 5698.6 5699.7 5741.3 5741.6 5791.7 5793.3 5802.6 5352.2 5558.1 5606.0 5619.9 5647.6 5569.6 5597.7 5601.2 5607.0 5609.2 5256.9 5477.6 5499.0 5537.0 5582.6 5589.6 5650.2 5656.1 5656.4 5676.6 5468.4 5477.6 5487.1 5489.5 5524.8 11:32:26 INFO - PROCESS | 17730 | 11:32:26 INFO - PROCESS | 17730 | [#1] ext.html Cycles:180 Average:50927.53 Median:37013.81 stddev:96899.65 (261.8%) stddev-sans-first:97097.86 11:32:26 INFO - PROCESS | 17730 | Values: 620.4 654.2 654.7 656.9 661.1 35391.1 37010.0 37017.6 37148.1 37176.4 44392.8 45116.5 45117.0 45118.5 45329.3 8746.9 8912.2 8944.1 8953.0 8958.6 8834.9 8978.2 8986.9 8989.1 8995.2 8956.1 9031.0 9045.5 9046.4 9049.2 8936.0 9023.6 9024.9 9043.4 9047.4 8731.0 8797.8 8854.4 8864.0 8872.5 40616.0 40887.2 41148.4 41170.8 41199.8 3352.7 3363.3 3403.7 3527.2 3568.1 29040.4 29949.9 30095.2 30119.5 30388.0 4210.6 4245.3 4249.1 4318.7 4336.8 321552.0 323259.4 324810.0 325399.0 325566.0 45912.5 50724.5 57826.4 58027.7 58383.4 53880.5 54492.5 54514.0 54522.0 54567.5 15768.4 15935.4 15939.0 15957.8 15960.7 11464.0 12134.0 12423.4 12935.7 13013.7 18314.2 18318.5 18401.9 18450.7 18536.4 7112.9 7198.6 7264.1 7286.2 7405.4 1012.7 1132.5 1149.2 1149.4 1168.8 32442.5 32562.0 32663.5 32852.0 32983.8 1110.4 1160.9 1167.4 1184.6 1219.9 16836.3 17311.9 17370.9 17398.0 17403.5 488066.0 493790.0 494779.0 496006.0 496493.0 55700.4 56235.7 56421.7 56556.0 56601.4 1307.8 1317.9 1342.6 1405.3 1446.8 28178.9 28923.6 29247.3 29579.0 29713.9 40729.6 41150.8 41216.2 41216.8 41230.8 223630.0 228714.0 229273.0 229317.0 229383.0 23096.8 23689.9 25095.4 25556.5 25957.9 40737.8 40830.0 41407.6 41632.2 42566.6 34673.3 35415.1 35448.0 35730.8 36013.6 35452.6 35957.1 36314.6 36447.8 37351.0 38211.2 39388.6 39887.0 40094.6 40125.6 33038.0 34439.0 34675.3 34959.5 35125.5 26754.3 26850.9 27051.9 27265.0 27324.3 11:32:26 INFO - PROCESS | 17730 | 11:32:26 INFO - PROCESS | 17730 | [#2] jquery.html Cycles:180 Average:28537.31 Median:3431.41 stddev:72096.69 (2101.1%) stddev-sans-first:72267.97 11:32:26 INFO - PROCESS | 17730 | Values: 392.5 396.6 400.2 401.6 413.9 17078.1 17686.2 18145.6 18156.1 18315.7 17557.1 18417.7 18524.7 18695.9 19165.4 5659.9 5807.7 5842.3 6975.1 7377.3 7297.6 7301.6 7330.2 7354.2 7359.2 7018.9 7379.2 7386.3 7386.9 7392.7 6744.9 7039.7 7095.0 7290.3 7352.2 6784.2 6812.1 6814.9 6861.5 6866.0 24691.6 25483.7 25511.0 25533.1 26066.6 2380.0 2454.4 2508.4 2730.4 2964.2 14610.6 14934.4 15055.4 15413.1 16293.8 1969.2 2046.5 2051.9 2089.6 2099.9 90428.5 92147.5 93128.0 93635.0 94102.0 17031.3 17599.5 18114.9 18642.8 18842.2 30835.8 31876.8 32077.8 32112.7 32115.0 9513.3 9755.9 9759.7 9807.7 9839.6 8051.8 8124.5 8141.3 8251.5 8313.5 8610.2 8670.8 8825.1 8870.1 9017.9 3264.6 3273.5 3413.8 3449.0 3546.2 923.5 1031.7 1063.6 1110.7 1122.4 18070.3 18226.5 18611.4 19697.3 19780.0 995.3 1006.2 1019.3 1023.5 1037.5 10315.3 10722.2 10769.1 10817.4 10850.9 426444.0 433954.0 434810.0 439327.0 442738.0 84824.0 88859.0 89182.6 89213.1 89525.0 1014.2 1014.5 1039.6 1042.0 1046.0 16464.2 16696.6 17075.7 17079.8 17222.6 37907.0 38074.0 38308.2 39381.6 40183.6 53053.2 54382.5 54631.5 54677.7 54908.7 8420.5 8673.1 8715.8 8764.3 8806.1 11980.7 12712.6 13310.2 13363.1 13393.4 5701.7 9309.1 10214.3 11516.7 11875.4 10316.2 10495.9 10612.4 10614.9 10615.2 6586.5 8364.3 11234.3 11891.1 12047.8 8090.1 8126.4 8174.6 8200.1 8253.1 8240.0 11026.5 11999.8 12202.7 12237.5 11:32:26 INFO - PROCESS | 17730 | 11:32:26 INFO - PROCESS | 17730 | [#3] mootools.html Cycles:180 Average:5450.42 Median:5016.39 stddev:3023.85 (60.3%) stddev-sans-first:3016.24 11:32:26 INFO - PROCESS | 17730 | Values: 1300.7 1486.6 1517.2 1644.6 1771.7 7866.9 8145.1 8151.3 8175.6 8177.3 7927.3 8104.2 8125.8 8127.8 8135.2 1941.5 2174.9 2255.2 2317.8 2355.6 2244.2 2255.2 2256.5 2257.9 2258.9 2259.7 2315.7 2329.5 2335.0 2335.8 2007.3 2119.1 2172.6 2176.5 2182.8 2235.7 2251.0 2252.9 2260.8 2281.5 8075.6 8103.6 8142.2 8151.0 8165.3 4799.1 5046.4 5086.6 5099.9 5124.8 3149.5 3150.5 3241.4 3284.8 3329.3 1059.9 1071.8 1075.3 1100.1 1191.6 11264.3 11297.2 11324.6 11328.6 11330.6 4443.4 4502.1 4575.1 4594.5 4602.0 9584.0 9587.8 9597.7 9598.3 9600.1 4544.8 5029.3 5041.1 5059.5 5060.6 4583.4 4661.6 4666.3 4680.4 4693.0 3794.7 3848.0 3909.3 3930.1 3946.4 1228.7 1245.8 1249.2 1256.6 1256.9 788.5 812.1 898.8 934.0 982.6 5465.8 5506.3 5570.1 5678.0 5705.9 971.9 987.3 987.7 988.7 1009.8 3865.1 3936.8 3950.5 3955.3 3999.1 9564.7 10111.5 10148.9 10243.2 10255.5 10114.6 10114.8 10216.8 10301.0 10326.1 7440.0 7484.7 7611.9 7666.8 7738.5 5660.4 5676.8 5789.8 5817.7 5936.6 9194.9 9581.8 9583.5 9629.8 9721.0 9453.8 9656.3 9674.5 9699.4 9823.1 6599.5 6735.6 7158.5 7226.6 7317.1 7869.3 7912.6 7934.7 7935.4 7963.8 6889.0 7105.9 7123.8 7195.9 7212.4 6931.5 6998.2 7068.4 7110.0 7156.1 6269.3 6385.6 6410.5 6437.5 6466.9 4849.7 4904.1 4930.5 4950.1 5003.5 4936.8 4967.6 4986.5 5003.4 5040.9 11:32:26 INFO - PROCESS | 17730 | 11:32:26 INFO - PROCESS | 17730 | [#4] prototype.html Cycles:180 Average:4684.33 Median:5331.41 stddev:1384.32 (26.0%) stddev-sans-first:1349.01 11:32:26 INFO - PROCESS | 17730 | Values: 326.6 332.0 332.1 332.6 334.0 5206.7 5277.6 5280.2 5295.7 5308.5 5234.8 5240.4 5255.3 5261.3 5274.4 3899.0 3920.3 4046.2 4049.3 4119.9 4096.4 4107.3 4115.6 4141.4 4146.1 3918.9 4084.8 4098.6 4102.4 4108.2 3956.9 4051.6 4060.2 4062.9 4094.8 3539.7 3606.1 3613.1 3613.3 3622.1 4953.2 4995.5 5019.5 5038.9 5050.7 4560.0 4688.8 4691.1 4701.6 4702.9 5333.9 5403.6 5404.6 5413.7 5424.7 3948.9 3980.9 3984.2 4001.4 4002.9 5496.1 5645.7 5655.6 5658.4 5691.0 4050.2 4057.7 4075.7 4085.5 4100.8 4088.9 4126.2 4138.7 4151.7 4153.1 4468.6 4637.9 4641.1 4651.7 4671.3 5400.1 5443.8 5455.6 5486.8 5513.4 1492.7 1499.5 1499.6 1507.6 1507.8 950.8 960.6 976.1 1020.1 1039.6 5448.8 5477.8 5519.2 5536.8 5538.8 5891.6 5921.4 5922.5 5923.6 5926.0 5328.9 5492.7 5516.4 5532.5 5552.2 3095.9 3106.3 3120.3 3128.2 3133.8 5912.1 6005.9 6018.8 6023.1 6041.8 5962.6 5980.5 5993.7 6004.9 6012.5 5985.3 5988.9 6003.3 6017.5 6068.2 5763.0 5773.4 5857.3 5876.2 5914.3 5810.9 5819.0 5826.6 5828.1 5847.9 5511.7 6021.0 6039.9 6048.4 6058.7 3921.3 3979.5 3985.8 3996.2 4001.0 5599.9 5656.0 5657.6 5665.0 5689.5 5377.4 5477.7 5490.8 5546.4 5576.3 5162.9 5300.7 5510.7 5514.8 5524.2 5389.5 5428.3 5439.5 5450.0 5461.4 5306.0 5534.7 5559.7 5560.6 5561.3 5354.4 5382.3 5390.3 5395.3 5434.9 11:32:26 INFO - PROCESS | 17730 | 11:32:26 INFO - PROCESS | 17730 | [#5] yui.html Cycles:180 Average:14730.63 Median:4574.57 stddev:17532.06 (383.3%) stddev-sans-first:17550.09 11:32:26 INFO - PROCESS | 17730 | Values: 812.1 850.5 851.3 870.7 872.6 13674.0 14009.2 14019.9 14058.1 14105.4 11136.4 13080.9 13189.7 13197.8 13200.2 805.4 832.2 833.6 835.3 836.6 823.4 829.2 829.9 830.1 831.7 707.7 875.9 877.8 877.8 878.0 843.5 877.8 878.3 878.3 878.4 623.2 623.7 625.6 625.7 626.4 13238.7 13259.6 13264.1 13282.7 13284.9 12062.5 12913.3 13539.0 13662.4 13724.3 12137.2 12379.3 12395.8 12403.9 12427.5 4486.0 4490.1 4523.0 4543.0 4586.0 49091.3 49338.3 50258.0 50394.2 50481.2 10614.5 10739.9 10876.8 10962.9 11010.6 18213.2 18294.5 18405.6 18426.5 18446.9 8142.5 8474.7 8503.7 8523.0 8735.8 4535.0 4563.3 4585.8 4618.9 4709.4 3309.3 3371.6 3380.0 3388.5 3527.5 579.3 598.2 612.1 612.3 676.9 587.7 651.1 706.6 730.5 758.4 9072.4 9725.1 9790.6 9803.0 9806.4 740.3 755.6 758.0 780.1 781.3 4183.9 4295.9 4389.0 4446.1 4479.7 67028.0 67192.7 68264.7 68428.6 69080.6 40923.0 42755.6 56228.4 57033.7 59838.0 51510.0 52506.7 54487.2 54842.5 56140.7 8848.3 8898.1 8910.4 8918.3 8918.6 33869.7 34075.8 34681.7 35203.0 35276.8 47517.8 48905.8 48961.5 49094.5 49279.8 11627.4 11630.5 11754.4 11800.0 12048.0 11216.9 11811.4 11999.9 12174.6 12704.4 11324.9 11545.8 11749.9 11805.2 11877.2 11534.8 11557.2 11699.7 11794.1 11846.2 10341.4 10379.2 10925.2 11263.4 11519.6 9914.7 10095.7 10102.0 10142.7 10558.1 9986.9 10068.3 10074.2 10094.9 10162.6 11:32:26 INFO - PROCESS | 17730 | -------- Summary: end -------- 11:32:26 INFO - PROCESS | 17730 | 11:32:27 INFO - TEST-INFO | 17730: exit 0 11:32:27 INFO - TEST-OK | dromaeo_css | took 1113344ms 11:32:27 INFO - TEST-START | kraken 11:32:27 INFO - operating with platform_type : linux_ 11:32:27 INFO - Initialising browser for kraken test... 11:32:27 INFO - TEST-INFO | started process 17915 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRUQhGh/profile http://localhost:47713/getInfo.html) 11:32:31 INFO - PROCESS | 17915 | __metrics Screen width/height:1600/1200 11:32:31 INFO - PROCESS | 17915 | colorDepth:24 11:32:31 INFO - PROCESS | 17915 | Browser inner width/height: 1024/697 11:32:31 INFO - PROCESS | 17915 | __metrics 11:32:32 ERROR - PROCESS | 17915 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:32:33 INFO - TEST-INFO | 17915: exit 0 11:32:33 INFO - Browser initialized. 11:32:33 INFO - Running cycle 1/1 for kraken test... 11:32:33 INFO - TEST-INFO | started process 17999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRUQhGh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:44 INFO - PROCESS | 17999 | RSS: Main: 154038272 11:32:44 INFO - PROCESS | 17999 | 11:32:47 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47713/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:48 INFO - PROCESS | 17999 | RSS: Main: 209739776 11:32:48 INFO - PROCESS | 17999 | 11:32:51 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47713/tests/kraken/driver.html?testName=audio-dft) 11:32:51 INFO - PROCESS | 17999 | RSS: Main: 195305472 11:32:51 INFO - PROCESS | 17999 | 11:32:54 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47713/tests/kraken/driver.html?testName=audio-fft) 11:32:55 INFO - PROCESS | 17999 | RSS: Main: 265510912 11:32:55 INFO - PROCESS | 17999 | 11:32:57 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47713/tests/kraken/driver.html?testName=audio-oscillator) 11:32:57 INFO - PROCESS | 17999 | RSS: Main: 173477888 11:32:57 INFO - PROCESS | 17999 | 11:33:00 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47713/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:33:00 INFO - PROCESS | 17999 | RSS: Main: 178401280 11:33:00 INFO - PROCESS | 17999 | 11:33:03 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47713/tests/kraken/driver.html?testName=imaging-darkroom) 11:33:04 INFO - PROCESS | 17999 | RSS: Main: 214712320 11:33:04 INFO - PROCESS | 17999 | 11:33:07 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47713/tests/kraken/driver.html?testName=imaging-desaturate) 11:33:08 INFO - PROCESS | 17999 | RSS: Main: 215298048 11:33:08 INFO - PROCESS | 17999 | 11:33:11 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47713/tests/kraken/driver.html?testName=json-parse-financial) 11:33:11 INFO - PROCESS | 17999 | RSS: Main: 215408640 11:33:11 INFO - PROCESS | 17999 | 11:33:13 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47713/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:14 INFO - PROCESS | 17999 | RSS: Main: 204578816 11:33:14 INFO - PROCESS | 17999 | 11:33:15 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47713/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:16 INFO - PROCESS | 17999 | RSS: Main: 204271616 11:33:16 INFO - PROCESS | 17999 | 11:33:18 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47713/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:19 INFO - PROCESS | 17999 | RSS: Main: 216051712 11:33:19 INFO - PROCESS | 17999 | 11:33:21 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:22 INFO - PROCESS | 17999 | RSS: Main: 223838208 11:33:22 INFO - PROCESS | 17999 | 11:33:24 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:25 INFO - PROCESS | 17999 | RSS: Main: 220438528 11:33:25 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | Cycle 1(1): loaded http://localhost:47713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47713/tests/kraken/driver.html?testName=ai-astar) 11:33:27 INFO - PROCESS | 17999 | RSS: Main: 284418048 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | __start_tp_report 11:33:27 INFO - PROCESS | 17999 | _x_x_mozilla_page_load 11:33:27 INFO - PROCESS | 17999 | _x_x_mozilla_page_load_details 11:33:27 INFO - PROCESS | 17999 | |i|pagename|runs| 11:33:27 INFO - PROCESS | 17999 | |0;ai-astar;113;114;110;111;112;112;102;112;112;111 11:33:27 INFO - PROCESS | 17999 | |1;audio-beat-detection;157;127;153;193;136;157;158;128;188;134 11:33:27 INFO - PROCESS | 17999 | |2;audio-dft;162;161;161;162;162;161;161;161;161;162 11:33:27 INFO - PROCESS | 17999 | |3;audio-fft;74;74;111;112;75;76;77;137;104;77 11:33:27 INFO - PROCESS | 17999 | |4;audio-oscillator;93;93;145;92;92;92;147;93;92;159 11:33:27 INFO - PROCESS | 17999 | |5;imaging-gaussian-blur;117;117;116;120;116;116;116;116;117;116 11:33:27 INFO - PROCESS | 17999 | |6;imaging-darkroom;146;145;145;145;146;146;146;146;146;145 11:33:27 INFO - PROCESS | 17999 | |7;imaging-desaturate;95;94;94;95;96;94;95;95;94;94 11:33:27 INFO - PROCESS | 17999 | |8;json-parse-financial;61;60;62;61;66;61;62;83;59;58 11:33:27 INFO - PROCESS | 17999 | |9;json-stringify-tinderbox;61;61;61;60;62;60;62;62;62;62 11:33:27 INFO - PROCESS | 17999 | |10;stanford-crypto-aes;85;76;77;76;77;78;79;77;77;78 11:33:27 INFO - PROCESS | 17999 | |11;stanford-crypto-ccm;134;124;124;123;125;136;132;124;170;125 11:33:27 INFO - PROCESS | 17999 | |12;stanford-crypto-pbkdf2;167;170;163;172;168;168;167;165;164;166 11:33:27 INFO - PROCESS | 17999 | |13;stanford-crypto-sha256-iterative;70;70;69;69;72;71;67;67;69;68 11:33:27 INFO - PROCESS | 17999 | __end_tp_report 11:33:27 INFO - PROCESS | 17999 | __start_cc_report 11:33:27 INFO - PROCESS | 17999 | _x_x_mozilla_cycle_collect,1675 11:33:27 INFO - PROCESS | 17999 | __end_cc_report 11:33:27 INFO - PROCESS | 17999 | __startTimestamp1461609207588__endTimestamp 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | ------- Summary: start ------- 11:33:27 INFO - PROCESS | 17999 | Number of tests: 14 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.31 (3.0%) stddev-sans-first:3.43 11:33:27 INFO - PROCESS | 17999 | Values: 113.0 114.0 110.0 111.0 112.0 112.0 102.0 112.0 112.0 111.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:157.00 stddev:23.17 (14.8%) stddev-sans-first:24.54 11:33:27 INFO - PROCESS | 17999 | Values: 157.0 127.0 153.0 193.0 136.0 157.0 158.0 128.0 188.0 134.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 11:33:27 INFO - PROCESS | 17999 | Values: 162.0 161.0 161.0 162.0 162.0 161.0 161.0 161.0 161.0 162.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#3] audio-fft Cycles:10 Average:91.70 Median:74.50 stddev:22.54 (30.3%) stddev-sans-first:22.98 11:33:27 INFO - PROCESS | 17999 | Values: 74.0 74.0 111.0 112.0 75.0 76.0 77.0 137.0 104.0 77.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:92.00 stddev:28.20 (30.7%) stddev-sans-first:29.25 11:33:27 INFO - PROCESS | 17999 | Values: 93.0 93.0 145.0 92.0 92.0 92.0 147.0 93.0 92.0 159.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:116.50 stddev:1.25 (1.1%) stddev-sans-first:1.32 11:33:27 INFO - PROCESS | 17999 | Values: 117.0 117.0 116.0 120.0 116.0 116.0 116.0 116.0 117.0 116.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:33:27 INFO - PROCESS | 17999 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 11:33:27 INFO - PROCESS | 17999 | Values: 95.0 94.0 94.0 95.0 96.0 94.0 95.0 95.0 94.0 94.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:61.50 stddev:7.24 (11.8%) stddev-sans-first:7.63 11:33:27 INFO - PROCESS | 17999 | Values: 61.0 60.0 62.0 61.0 66.0 61.0 62.0 83.0 59.0 58.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 11:33:27 INFO - PROCESS | 17999 | Values: 61.0 61.0 61.0 60.0 62.0 60.0 62.0 62.0 62.0 62.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:77.50 stddev:2.62 (3.4%) stddev-sans-first:0.97 11:33:27 INFO - PROCESS | 17999 | Values: 85.0 76.0 77.0 76.0 77.0 78.0 79.0 77.0 77.0 78.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:128.50 stddev:14.28 (11.1%) stddev-sans-first:15.12 11:33:27 INFO - PROCESS | 17999 | Values: 134.0 124.0 124.0 123.0 125.0 136.0 132.0 124.0 170.0 125.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.50 stddev:2.71 (1.6%) stddev-sans-first:2.87 11:33:27 INFO - PROCESS | 17999 | Values: 167.0 170.0 163.0 172.0 168.0 168.0 167.0 165.0 164.0 166.0 11:33:27 INFO - PROCESS | 17999 | 11:33:27 INFO - PROCESS | 17999 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.62 (2.3%) stddev-sans-first:1.69 11:33:27 INFO - PROCESS | 17999 | Values: 70.0 70.0 69.0 69.0 72.0 71.0 67.0 67.0 69.0 68.0 11:33:27 INFO - PROCESS | 17999 | -------- Summary: end -------- 11:33:27 INFO - PROCESS | 17999 | 11:33:28 INFO - TEST-INFO | 17999: exit 0 11:33:28 INFO - TEST-OK | kraken | took 61416ms 11:33:28 INFO - SUITE-END | took 1174s 11:33:28 INFO - Completed test suite (00:19:34) 11:33:28 INFO - javascript benchmark 11:33:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3113.3306339137084, 3141.921451963702, 3184.5860038195033, 3193.9520907186397, 3223.806571605704, 5230.074665740581, 5236.921446178301, 5296.576273898088, 5325.760340784665, 5349.22436246744, 5277.182036784295, 5320.361556613212, 5408.188771684249, 5418.106012507931, 5458.863528411782, 4778.044391121781, 4778.1638213312535, 4787.425508938933, 4792.520747925215, 4940.654154209206, 4865.48912364202, 4923.507649235065, 4934.358533390654, 4949.430815456215, 4957.132501812169, 4730.101280756662, 4807.254875494269, 4846.39420072491, 4872.027157519577, 4932.284818701304, 4881.389826271716, 4900.607951363918, 4906.337644417994, 4910.140725373081, 4954.182559877616, 4862.927056094161, 4875.804967801284, 4878.292647566083, 4893.266010098479, 4909.361782968192, 5216.973915130438, 5264.315638966948, 5307.389650190239, 5345.866353341197, 5350.732463376816, 5691.317041954951, 5695.971520142372, 5711.8000869969765, 5715.1713001614535, 5716.742746576372, 5724.198612194296, 5755.194272801811, 5755.366909639936, 5755.942440575583, 5759.0, 5178.741062946838, 5315.574754019708, 5369.5167434931045, 5376.301080859464, 5379.838604841861, 5927.022041363213, 5935.406459354116, 5935.406459354116, 5941.049432090845, 5959.314678811906, 5494.066008778517, 5685.374608793029, 5687.374388817227, 5692.800751973744, 5699.857503562361, 5627.0, 5651.0, 5665.065264231438, 5699.487046165865, 5715.057015592464, 5690.2033715279895, 5700.714964251771, 5703.7148142592705, 5704.743286552032, 5705.400932902068, 5606.439356064361, 5680.488756011979, 5688.260526131577, 5696.145578163226, 5709.743061562157, 4258.1057977825, 4277.272863613193, 4318.784060796947, 4320.913581728348, 4322.956770432255, 3826.7321287510163, 3827.1771569112775, 3836.5779764225913, 3865.5747867734526, 3879.3017256893468, 5211.973940130351, 5301.469853014668, 5327.0411325961695, 5343.358796944314, 5350.250964864922, 5674.460926212003, 5699.800506982236, 5702.0, 5717.714114294268, 5745.540356771448, 5335.226392173191, 5343.625946183807, 5344.064788661969, 5347.144456886879, 5352.919706204332, 4692.976535117371, 4756.548127927841, 4757.643176761688, 4800.759962001886, 4813.807447702053, 5866.442687944724, 5880.206172166702, 5892.351841297454, 5900.734466948998, 5925.851853703692, 5712.057510510802, 5732.971335143297, 5739.971300143639, 5757.0, 5770.451807078321, 5597.776088956559, 5857.0, 5885.764569417175, 5959.344472107978, 5959.880802384015, 5664.461876121762, 5679.574031947538, 5696.857578560403, 5698.601097923106, 5699.658020518782, 5741.25363702716, 5741.569382296261, 5791.681457519709, 5793.333766616893, 5802.622829516068, 5352.170413585901, 5558.138488534284, 5605.971970140124, 5619.8595035124445, 5647.604667673388, 5569.610127291051, 5597.692126933058, 5601.187827765033, 5607.046802043581, 5609.24275222856, 5256.868578285421, 5477.643953143033, 5499.0, 5536.975659503005, 5582.5533957282505, 5589.608727389206, 5650.152477128464, 5656.123300888369, 5656.377798442086, 5676.5742569308295, 5468.398476167539, 5477.561795056466, 5487.067198576331, 5489.533389661923, 5524.779008839601], "value": 5259.689531441365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.4106099205754, 654.2214764430328, 654.70538257784, 656.9080328753976, 661.0976017735792, 35391.11522211943, 37010.0, 37017.629823701755, 37148.07129821759, 37176.44235336472, 44392.778036109856, 45116.54883451165, 45117.0, 45118.54881451184, 45329.32006019913, 8746.868796968034, 8912.24245939096, 8944.060873608276, 8953.0, 8958.641654333818, 8834.911650883505, 8978.23684986777, 8986.910130898705, 8989.146031127066, 8995.235404990584, 8956.149165829236, 9030.954845225764, 9045.502497362642, 9046.3667543272, 9049.185573298402, 8935.955320223422, 9023.639054437816, 9024.909750902472, 9043.366964312534, 9047.366684332099, 8731.0, 8797.824043519095, 8854.380193386465, 8864.024957254696, 8872.46765194084, 40616.0, 40887.182256355, 41148.38277425841, 41170.794146029075, 41199.7940010301, 3352.664733526652, 3363.3105213431186, 3403.6596340366013, 3527.1887465882733, 3568.125809176742, 29040.41919161626, 29949.85025074861, 30095.247618809484, 30119.548206776915, 30388.0, 4210.5578914214175, 4245.341971994346, 4249.107687385653, 4318.740875547446, 4336.7831608419765, 321552.0, 323259.38370308233, 324810.0, 325399.0, 325566.0, 45912.5408745915, 50724.492755072715, 57826.42173578295, 58027.70986145042, 58383.41616583865, 53880.46119538833, 54492.455075448735, 54514.0, 54522.0, 54567.45432545624, 15768.369265229492, 15935.362585496681, 15939.0, 15957.840421595867, 15960.680786384208, 11464.025557827512, 12134.0, 12423.44094515749, 12935.741285174245, 13013.739725205443, 18314.175862085973, 18318.542036449195, 18401.90799045996, 18450.723239151423, 18536.44390668282, 7112.92887071133, 7198.58847286165, 7264.128304603376, 7286.23494533077, 7405.44459165554, 1012.7084988085666, 1132.4677401621225, 1149.2242736153064, 1149.3793351590048, 1168.8480497535265, 32442.513362299585, 32562.0, 32663.510047349308, 32852.0, 32983.83508082492, 1110.4447776111945, 1160.930344179352, 1167.416291854073, 1184.644606618011, 1219.9268043917393, 16836.32654693823, 17311.94082071265, 17370.913145434446, 17397.955357812585, 17403.47789566315, 488066.0, 493790.0, 494779.0, 496006.0, 496493.0, 55700.44299556952, 56235.71882140645, 56421.71789141028, 56556.0, 56601.43398566044, 1307.843058832946, 1317.8748018938186, 1342.5703774791973, 1405.3465138710549, 1446.8263808342856, 28178.85910570434, 28923.566146507397, 29247.268818279714, 29579.0, 29713.851430742707, 40729.59270407258, 41150.79424602858, 41216.175676485705, 41216.79391603143, 41230.793846031775, 223630.0, 228714.0, 229273.0, 229317.0, 229383.0, 23096.769032310134, 23689.881550592138, 25095.372615684755, 25556.488870222118, 25957.87021064958, 40737.79631101825, 40830.0, 41407.585924141575, 41632.167356653306, 42566.574334256264, 34673.30653386968, 35415.11462213465, 35448.0, 35730.821345893106, 36013.63986360103, 35452.64547354596, 35957.1010724734, 36314.63685363113, 36447.81776091208, 37351.0, 38211.23577528489, 39388.60611393849, 39887.0, 40094.599054009086, 40125.59874401218, 33038.0, 34439.0, 34675.306493870485, 34959.475607866414, 35125.473117902744, 26754.331141721614, 26850.865745671148, 27051.86474067696, 27265.0, 27324.316892077855], "value": 18979.33778975955, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.46428624926966, 396.5756640394777, 400.2335527464905, 401.61445012787726, 413.87790601772474, 17078.146092695348, 17686.204120814564, 18145.63708725825, 18156.092195390243, 18315.725264121033, 17557.122143892786, 18417.723734143965, 18524.72212916804, 18695.90652046738, 19165.42503724887, 5659.8585035374035, 5807.680577568232, 5842.32813226478, 6975.128108986377, 7377.299156580117, 7297.562146271214, 7301.598412087333, 7330.230325815793, 7354.227806080365, 7359.153697324796, 7018.89471657923, 7379.151397589266, 7386.335229829314, 7386.889196662054, 7392.741254056109, 6744.9325506745045, 7039.718411263543, 7095.04216930718, 7290.307420795016, 7352.154502232232, 6784.151981002375, 6812.080369150151, 6814.931850681479, 6861.4853885958755, 6866.0, 24691.62962555563, 25483.745162548323, 25511.0, 25533.10634127815, 26066.609000865003, 2380.0479808076734, 2454.374134595667, 2508.435601989556, 2730.426610411816, 2964.199666090165, 14610.634734131625, 14934.402623895032, 15055.397784088733, 15413.075215486995, 16293.755593666105, 1969.241841890868, 2046.467918341227, 2051.8974051297378, 2089.5507465894752, 2099.8950052497466, 90428.54785726029, 92147.53926230325, 93128.0, 93635.0, 94101.99999999932, 17031.318747250218, 17599.472015839547, 18114.909425452788, 18642.81357186438, 18842.15210315539, 30835.84582077075, 31876.840615796773, 32077.754557180775, 32112.678873211436, 32115.0, 9513.286503512265, 9755.9024409755, 9759.658411955548, 9807.656732014346, 9839.606415743434, 8051.798705032421, 8124.512529248264, 8141.267285944294, 8251.504909705436, 8313.459625124347, 8610.182032706884, 8670.82658346842, 8825.117488251251, 8870.112988701207, 9017.864732029026, 3264.5919260092487, 3273.463066123773, 3413.846376913045, 3448.9643124532067, 3546.2225776170712, 923.5059243304934, 1031.742064483879, 1063.6277302944063, 1110.7056629993058, 1122.4499995002552, 18070.277188912296, 18226.45320640383, 18611.441656750318, 19697.310594129423, 19780.0, 995.2585323933715, 1006.1900170362928, 1019.3323373190572, 1023.4626820919077, 1037.4657051618422, 10315.27793054479, 10722.195835312383, 10769.138468922467, 10817.350958942488, 10850.891491085145, 426444.0, 433954.0, 434810.0, 439327.0, 442738.0, 84824.0, 88859.0, 89182.55408723044, 89213.10786892047, 89525.0, 1014.2393205096178, 1014.4724743133529, 1039.6257347354795, 1041.9687409377732, 1046.0376453662648, 16464.176791160153, 16696.582585435463, 17075.65848683044, 17079.829201707824, 17222.569435764206, 37907.0, 38074.0, 38308.23383532369, 39381.60618393894, 40183.59816401799, 53053.20420193623, 54382.456175437736, 54631.453685462635, 54677.72661136669, 54908.725456372464, 8420.536870472182, 8673.132686731276, 8715.825683486422, 8764.255038321815, 8806.119388061143, 11980.700482488008, 12712.555060572835, 13310.201387916368, 13363.1313964592, 13393.397297121848, 5701.714914254354, 9309.069093090637, 10214.285000050222, 11516.654500364668, 11875.406229688653, 10316.17470602365, 10495.947520262655, 10612.363258204532, 10614.946925265323, 10615.203859710708, 6586.538942274186, 8364.289035432057, 11234.269772464764, 11891.10816688769, 12047.819282710941, 8090.11008789021, 8126.390520710852, 8174.569450346046, 8200.0979892213, 8253.133420990709, 8240.0, 11026.503807328529, 11999.820002699791, 12202.694932626755, 12237.510499579917], "value": 10170.530784796581, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.655326338521, 1486.5614643680117, 1517.2034681792059, 1644.6464010237796, 1771.7165253559424, 7866.881996770046, 8145.144759800224, 8151.307138893194, 8175.591220438969, 8177.304929081035, 7927.326177274924, 8104.230098140667, 8125.75622731319, 8127.796805079876, 8135.186481351861, 1941.5437372217518, 2174.8586341887726, 2255.210676263311, 2317.8261630377706, 2355.634876594122, 2244.2145249162827, 2255.1768604459335, 2256.4584499720113, 2257.8758168300737, 2258.9435264118365, 2259.6610508423705, 2315.7221133463922, 2329.5457385809773, 2335.0309621507054, 2335.824813139013, 2007.3275452723356, 2119.07820098257, 2172.576347612216, 2176.4667656424117, 2182.84720069596, 2235.7317121945307, 2250.9887450562805, 2252.8986195621237, 2260.762619924917, 2281.4638559938403, 8075.596220188967, 8103.635336409876, 8142.185781421869, 8150.959245203795, 8165.3059489943425, 4799.112164249625, 5046.419661738911, 5086.643934924557, 5099.872503187413, 5124.769385377667, 3149.5118256670253, 3150.4644210484043, 3241.3679332530164, 3284.753643476749, 3329.334133173351, 1059.9417032063234, 1071.8231491803842, 1075.349338764992, 1100.114407901639, 1191.6365508519898, 11264.267822591506, 11297.152713546517, 11324.6036388726, 11328.603498877499, 11330.603428880033, 4443.4445694288215, 4502.099580083931, 4575.107853968444, 4594.494605593382, 4601.953980460219, 9584.0, 9587.760305992406, 9597.664081757104, 9598.280128990353, 9600.135987760996, 4544.818207271672, 5029.2958985742025, 5041.092603331435, 5059.519345662156, 5060.5698515625845, 4583.427071616048, 4661.557152070548, 4666.300054991711, 4680.4149481314835, 4692.976535117303, 3794.734368594172, 3847.9807600962376, 3909.3354129798004, 3930.0960779020415, 3946.4080387941463, 1228.7051107734258, 1245.7570773699042, 1249.2067537113999, 1256.5602039286177, 1256.9308688022247, 788.4874831359662, 812.118851046621, 898.8382091223642, 934.0239449775002, 982.5774916785708, 5465.808696695596, 5506.339239291311, 5570.136628822539, 5678.0, 5705.857353566111, 971.9271054670928, 987.2792861211356, 987.683941138843, 988.6836212412103, 1009.8384258518602, 3865.1303456722576, 3936.8031598419966, 3950.506186726659, 3955.268275369066, 3999.140184860269, 9564.66523671668, 10111.544980475895, 10148.949255253825, 10243.180545556337, 10255.487225638688, 10114.634524339268, 10114.848277275847, 10216.846747298796, 10301.021402966706, 10326.122279606167, 7439.958405823189, 7484.738034168778, 7611.923880761232, 7666.769996900102, 7738.535687858746, 5660.433956604306, 5676.77292908279, 5789.797357092481, 5817.70911454434, 5936.614120082181, 9194.862077068716, 9581.808363832824, 9583.520823958635, 9629.759256018655, 9720.951395242979, 9453.810923781624, 9656.27577931672, 9674.516274186122, 9699.418034917928, 9823.066808653166, 6599.505037122139, 6735.562188457735, 7158.46311526648, 7226.566406015656, 7317.12194536659, 7869.291763741291, 7912.643931023233, 7934.722284720007, 7935.365170786438, 7963.761087167394, 6889.0, 7105.857882842418, 7123.82190445243, 7195.8560828784175, 7212.386947109345, 6931.514793964374, 6998.195207551197, 7068.363847253772, 7110.040144580622, 7156.141263048467, 6269.341719119427, 6385.553011289165, 6410.4871610272, 6437.549371544134, 6466.935330646634, 4849.684770489906, 4904.068227036994, 4930.457649658463, 4950.084234416644, 5003.474635163256, 4936.827211047596, 4967.627427942846, 4986.451490336132, 5003.399592048978, 5040.949590504048], "value": 4409.024904261333, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.564037010591, 332.04868053028065, 332.0784822118621, 332.55437713463954, 334.0379706445437, 5206.687598744078, 5277.604179686529, 5280.2343660169345, 5295.682259064449, 5308.522917489041, 5234.842954711365, 5240.397354304256, 5255.316808814849, 5261.289725887004, 5274.367075950881, 3898.9805050974705, 3920.2551515212017, 4046.150308435232, 4049.250888585621, 4119.876403707878, 4096.446979657738, 4107.301758701028, 4115.629593336599, 4141.378793181017, 4146.108586653869, 3918.941215881764, 4084.816183271745, 4098.569650186732, 4102.384642303663, 4108.198901214264, 3956.901077473072, 4051.6021972419467, 4060.2488539620117, 4062.939055914164, 4094.754314741095, 3539.6991255743037, 3606.0804494853905, 3613.0967258185456, 3613.2773445311045, 3622.094476380905, 4953.23224900141, 4995.475475075137, 5019.498050194988, 5038.874028149289, 5050.671706339113, 4559.954400456019, 4688.789004494806, 4691.132140554008, 4701.623870090384, 4702.858914232578, 5333.893322133536, 5403.648762830443, 5404.648697834628, 5413.702246376448, 5424.701641409721, 3948.940765888514, 3980.920381592352, 3984.183242435294, 4001.379786133154, 4002.939955900664, 5496.148097044925, 5645.689487078209, 5655.575831812631, 5658.359075867993, 5690.9837785973505, 4050.1697152083752, 4057.6753859691153, 4075.694322925792, 4085.4893138357706, 4100.753954762724, 4088.897777555585, 4126.236646220459, 4138.730982486129, 4151.667866570667, 4153.1070819773895, 4468.553144685506, 4637.86086417408, 4641.118187544355, 4651.720896746206, 4671.346011558385, 5400.135978243541, 5443.836684899459, 5455.563554915677, 5486.753096110685, 5513.365962914316, 1492.7462331403688, 1499.4526997645999, 1499.5801175670829, 1507.5778781941074, 1507.8416766239386, 950.8098380323963, 960.5725452173716, 976.1263669016191, 1020.1023099672241, 1039.6413237433073, 5448.809291674773, 5477.780888764405, 5519.199716041152, 5536.806211782568, 5538.833834984957, 5891.558133140032, 5921.3782552831335, 5922.460160358338, 5923.585349025613, 5925.970370148121, 5328.92006619901, 5492.670439773627, 5516.365617953907, 5532.5020748132865, 5552.223288547626, 3095.8916437924563, 3106.3010822565193, 3120.2979329651102, 3128.1710346758127, 3133.827639479805, 5912.08362703773, 6005.879882402415, 6018.849528761816, 6023.126646636213, 6041.758329666852, 5962.612430192024, 5980.491658209014, 5993.700314984233, 6004.939950600438, 6012.518998480111, 5985.25921299188, 5988.850278742979, 6003.309619393825, 6017.518598512109, 6068.150458935841, 5762.962666720031, 5773.364929857628, 5857.297124345106, 5876.236089308533, 5914.290285165807, 5810.883782324415, 5819.0, 5826.592138550261, 5828.125781132864, 5847.853803654943, 5511.669299842022, 6020.969895150496, 6039.879202415839, 6048.425399587032, 6058.666773327333, 3921.254961557295, 3979.4826672532386, 3985.8405663773124, 3996.1608062306077, 4001.039750459927, 5599.920043975879, 5656.0, 5657.632253903483, 5664.951983882995, 5689.544836412994, 5377.354717433933, 5477.67133971947, 5490.835274941598, 5546.389897111234, 5576.275084239023, 5162.870928226825, 5300.734963251745, 5510.669359838423, 5514.834554963358, 5524.226608274765, 5389.487998640123, 5428.348598168245, 5439.537639300704, 5450.0, 5461.371942226695, 5305.991861546294, 5534.667919924817, 5559.664940724824, 5560.638558493685, 5561.304836895388, 5354.4110147884485, 5382.281947616429, 5390.328998010629, 5395.271638328775, 5434.891302173855], "value": 4250.185192784852, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.1147948735877, 850.5449584472309, 851.293426456042, 870.7083127152404, 872.5593575244501, 13674.0, 14009.229492377941, 14019.85980140197, 14058.086224395433, 14105.365258563364, 11136.443177841116, 13080.934595327033, 13189.670258243525, 13197.802032969514, 13200.207987520755, 805.4241217529479, 832.1803024021334, 833.6248688090353, 835.2900034970287, 836.640244694781, 823.3989187892842, 829.1915382502073, 829.9170082991683, 830.0703212402118, 831.6590198018813, 707.7027648387664, 875.9430637008605, 877.7542288159326, 877.7673916412156, 877.9780505487382, 843.4686147726924, 877.7849426890389, 878.3061381508633, 878.3324673248313, 878.44218920985, 623.2365352443267, 623.6569886562372, 625.5808608232495, 625.7403177681302, 626.361111666098, 13238.66903327415, 13259.602211933561, 13264.071514993955, 13282.73434531304, 13284.933575332157, 12062.45718942641, 12913.289769062698, 13539.0, 13662.385192666354, 13724.313784310745, 12137.211081279776, 12379.319137447437, 12395.75208495834, 12403.875961240363, 12427.502899883993, 4485.9551404485865, 4490.124425736983, 4522.977385113087, 4542.977285113553, 4586.036932244233, 49091.263631045564, 49338.259926101135, 50258.0, 50394.24408633837, 50481.24278135831, 10614.469276536141, 10739.946300268604, 10876.836847447295, 10962.890371096346, 11010.614628487965, 18213.180406881722, 18294.451166465027, 18405.63188736218, 18426.539336516693, 18446.90776546109, 8142.51144931306, 8474.703385381605, 8503.659853605786, 8523.0, 8735.825283494421, 4535.006895448988, 4563.315502674559, 4585.816567337336, 4618.884527886763, 4709.364235828188, 3309.305045940331, 3371.561696979426, 3380.0197942596374, 3388.525606415104, 3527.453244747017, 579.3135134865198, 598.2193237824681, 612.091044798474, 612.2928018139056, 676.8815457295052, 587.7325816753367, 651.1144843013592, 706.5513398991677, 730.5073796153697, 758.3819187362282, 9072.364934454525, 9725.124738773544, 9790.608375664893, 9803.0, 9806.362586431858, 740.3268612934806, 755.6070843161525, 757.9772606821804, 780.0717146595533, 781.2617076862424, 4183.937629999855, 4295.871123866289, 4389.0, 4446.110777844444, 4479.70881892676, 67028.0, 67192.6640366795, 68264.65867670729, 68428.55214411048, 69080.58217962347, 40923.0, 42755.57244427578, 56228.437715623135, 57033.714831426405, 59838.0, 51510.0, 52506.737466313185, 54487.182692259645, 54842.451575483734, 56140.71929640326, 8848.292136629183, 8898.11018898105, 8910.376273660782, 8918.286537076889, 8918.554072296489, 33869.661303387635, 34075.829620851735, 34681.65318346784, 35203.0, 35276.82361588176, 47517.76241118772, 48905.755471222416, 48961.51038489712, 49094.509054908995, 49279.753601231765, 11627.360495172847, 11630.53477860876, 11754.353510556659, 11800.0, 12048.0, 11216.943915280372, 11811.350375729417, 11999.940000299943, 12174.57388991381, 12704.36478176106, 11324.886751132713, 11545.826812597987, 11749.941250294036, 11805.23265987708, 11877.22798018126, 11534.826977595176, 11557.190996630155, 11699.707507312385, 11794.056475482112, 11846.170768046153, 10341.391474181313, 10379.169666426516, 10925.180611454332, 11263.436828158723, 11519.596814111466, 9914.702558923243, 10095.697129086138, 10102.0, 10142.746431338981, 10558.10256128207, 9986.900130998887, 10068.345557538736, 10074.19406447497, 10094.899051009395, 10162.593496260362], "value": 6686.787295479075, "unit": "score"}], "name": "dromaeo_css", "value": 7091.9637595909, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 110.0, 111.0, 112.0, 112.0, 102.0, 112.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 153.0, 193.0, 136.0, 157.0, 158.0, 128.0, 188.0, 134.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 111.0, 112.0, 75.0, 76.0, 77.0, 137.0, 104.0, 77.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 145.0, 92.0, 92.0, 92.0, 147.0, 93.0, 92.0, 159.0], "value": 109.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 120.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 61.0, 66.0, 61.0, 62.0, 83.0, 59.0, 58.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 62.0, 60.0, 62.0, 62.0, 62.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 76.0, 77.0, 76.0, 77.0, 78.0, 79.0, 77.0, 77.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 124.0, 124.0, 123.0, 125.0, 136.0, 132.0, 124.0, 170.0, 125.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 163.0, 172.0, 168.0, 168.0, 167.0, 165.0, 164.0, 166.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 69.0, 72.0, 71.0, 67.0, 67.0, 69.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1554.3000000000002, "alertThreshold": 2.0}]} 11:33:28 INFO - Return code: 0 11:33:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:33:28 ERROR - # TBPL SUCCESS # 11:33:28 INFO - Running post-action listener: _resource_record_post_action 11:33:28 INFO - Running post-run listener: _resource_record_post_run 11:33:29 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 487202816; Read time: 8; Write time: 1126840 11:33:29 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 196661248; Read time: 0; Write time: 644224 11:33:29 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290541568; Read time: 8; Write time: 482616 11:33:29 INFO - Running post-run listener: _upload_blobber_files 11:33:29 INFO - Blob upload gear active. 11:33:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:29 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 11:33:29 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:29 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:30 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:33:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:33:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:31 INFO - (blobuploader) - INFO - Done attempting. 11:33:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:33:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:33:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:32 INFO - (blobuploader) - INFO - Done attempting. 11:33:32 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:32 INFO - Return code: 0 11:33:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2621194f3028883efdf69495c9f6442407a4bd0fc523400fcfc35ff9eb0dde2ac7a13652d7754b4cb2bbcd291113ce5ee390c141eaf8eb319c755008aae74bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e89e9e3592f338cdb383fbd282d5747c670796b543b017a24736c55899662f7a6b2f6c669c8189777cee21e410f72d6cc91ea335513c251b21d9d5878ba4e51b"} 11:33:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:32 INFO - Contents: 11:33:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2621194f3028883efdf69495c9f6442407a4bd0fc523400fcfc35ff9eb0dde2ac7a13652d7754b4cb2bbcd291113ce5ee390c141eaf8eb319c755008aae74bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e89e9e3592f338cdb383fbd282d5747c670796b543b017a24736c55899662f7a6b2f6c669c8189777cee21e410f72d6cc91ea335513c251b21d9d5878ba4e51b"} 11:33:32 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:32 INFO - Copying logs to upload dir... 11:33:32 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.912420 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-04-25 11:33:31.912179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 11:33:31.916111) ========= 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=af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397 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/sha512/2621194f3028883efdf69495c9f6442407a4bd0fc523400fcfc35ff9eb0dde2ac7a13652d7754b4cb2bbcd291113ce5ee390c141eaf8eb319c755008aae74bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e89e9e3592f338cdb383fbd282d5747c670796b543b017a24736c55899662f7a6b2f6c669c8189777cee21e410f72d6cc91ea335513c251b21d9d5878ba4e51b"} build_url:https://queue.taskcluster.net/v1/task/J0nMjWXwS3CE4cZ-egMTbw/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/J0nMjWXwS3CE4cZ-egMTbw/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/sha512/2621194f3028883efdf69495c9f6442407a4bd0fc523400fcfc35ff9eb0dde2ac7a13652d7754b4cb2bbcd291113ce5ee390c141eaf8eb319c755008aae74bd3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e89e9e3592f338cdb383fbd282d5747c670796b543b017a24736c55899662f7a6b2f6c669c8189777cee21e410f72d6cc91ea335513c251b21d9d5878ba4e51b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 11:33:31.940975) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:33:31.941303) ========= 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=af724c981e2a0f424dbabf99000001e7-1461607119.363136-823929397 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 11:33:32.026488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 11:33:32.026827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 11:33:32.027128) ========= ========= Total master_lag: 0.17 =========