builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1462803278.5 results: success (0) buildid: 20160509040557 builduid: 5e1b192add0c487182cf725d3895dd3e revision: 043082cb7bd8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:38.501371) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:38.501952) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:38.502227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:38.519383) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:38.519773) ========= 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=745a4373a2a16df560f216e000000264-1462803224.304042-1463327556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-09 07:14:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-05-09 07:14:38 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149593 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:38.680301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:38.680611) ========= 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=745a4373a2a16df560f216e000000264-1462803224.304042-1463327556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:38.730311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:38.730636) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 043082cb7bd8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 043082cb7bd8 --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=745a4373a2a16df560f216e000000264-1462803224.304042-1463327556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-09 07:14:38,913 Setting DEBUG logging. 2016-05-09 07:14:38,913 attempt 1/10 2016-05-09 07:14:38,913 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/043082cb7bd8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 07:14:39,172 unpacking tar archive at: mozilla-central-043082cb7bd8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547757 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:39.291482) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:39.291856) ========= script_repo_revision: 043082cb7bd8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:39.292262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:39.293064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 07:14:39.307475) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-09 07:14:39.307858) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=745a4373a2a16df560f216e000000264-1462803224.304042-1463327556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:14:39 INFO - MultiFileLogger online at 20160509 07:14:39 in /builds/slave/test 07:14:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:14:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:14:39 INFO - {'append_to_log': False, 07:14:39 INFO - 'base_work_dir': '/builds/slave/test', 07:14:39 INFO - 'blob_upload_branch': 'Firefox', 07:14:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:14:39 INFO - 'branch': 'Firefox', 07:14:39 INFO - 'buildbot_json_path': 'buildprops.json', 07:14:39 INFO - 'config_files': ('talos/linux_config.py',), 07:14:39 INFO - 'default_actions': ('clobber', 07:14:39 INFO - 'read-buildbot-config', 07:14:39 INFO - 'download-and-extract', 07:14:39 INFO - 'populate-webroot', 07:14:39 INFO - 'create-virtualenv', 07:14:39 INFO - 'install', 07:14:39 INFO - 'run-tests'), 07:14:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:14:39 INFO - 'download_minidump_stackwalk': True, 07:14:39 INFO - 'download_symbols': 'ondemand', 07:14:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:14:39 INFO - 'tooltool.py': '/tools/tooltool.py', 07:14:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:14:39 INFO - '/tools/misc-python/virtualenv.py')}, 07:14:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:14:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:14:39 INFO - 'installer_path': 'installer.exe', 07:14:39 INFO - 'log_level': 'info', 07:14:39 INFO - 'log_name': 'talos', 07:14:39 INFO - 'log_to_console': True, 07:14:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:14:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:14:39 INFO - 'opt_config_files': (), 07:14:39 INFO - 'pip_index': False, 07:14:39 INFO - 'sps_profile': False, 07:14:39 INFO - 'sps_profile_interval': 0, 07:14:39 INFO - 'suite': 'dromaeojs', 07:14:39 INFO - 'system_bits': '32', 07:14:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:14:39 INFO - 'title': 'talos-linux64-ix-032', 07:14:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:14:39 INFO - 'use_talos_json': True, 07:14:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:14:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:14:39 INFO - 'work_dir': 'build'} 07:14:39 INFO - ##### 07:14:39 INFO - ##### Running clobber step. 07:14:39 INFO - ##### 07:14:39 INFO - Running pre-action listener: _resource_record_pre_action 07:14:39 INFO - Running main action method: clobber 07:14:39 INFO - rmtree: /builds/slave/test/build 07:14:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:14:40 INFO - Running post-action listener: _resource_record_post_action 07:14:40 INFO - ##### 07:14:40 INFO - ##### Finished clobber step (success) 07:14:40 INFO - ##### 07:14:40 INFO - ##### 07:14:40 INFO - ##### Running read-buildbot-config step. 07:14:40 INFO - ##### 07:14:40 INFO - Running pre-action listener: _resource_record_pre_action 07:14:40 INFO - Running main action method: read_buildbot_config 07:14:40 INFO - Using buildbot properties: 07:14:40 INFO - { 07:14:40 INFO - "project": "", 07:14:40 INFO - "product": "firefox", 07:14:40 INFO - "script_repo_revision": "production", 07:14:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:14:40 INFO - "repository": "", 07:14:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:14:40 INFO - "buildid": "20160509040557", 07:14:40 INFO - "stage_platform": "linux64-pgo", 07:14:40 INFO - "basedir": "/builds/slave/test", 07:14:40 INFO - "nightly_build": "True", 07:14:40 INFO - "buildnumber": 767, 07:14:40 INFO - "slavename": "talos-linux64-ix-032", 07:14:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:14:40 INFO - "platform": "ubuntu64_hw", 07:14:40 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:14:40 INFO - "branch": "mozilla-central", 07:14:40 INFO - "repo_path": "mozilla-central", 07:14:40 INFO - "revision": "043082cb7bd8", 07:14:40 INFO - "pgo_build": "True", 07:14:40 INFO - "builduid": "5e1b192add0c487182cf725d3895dd3e", 07:14:40 INFO - "slavebuilddir": "test" 07:14:40 INFO - } 07:14:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:14:40 INFO - Running post-action listener: _resource_record_post_action 07:14:40 INFO - ##### 07:14:40 INFO - ##### Finished read-buildbot-config step (success) 07:14:40 INFO - ##### 07:14:40 INFO - ##### 07:14:40 INFO - ##### Running download-and-extract step. 07:14:40 INFO - ##### 07:14:40 INFO - Running pre-action listener: _resource_record_pre_action 07:14:40 INFO - Running main action method: download_and_extract 07:14:40 INFO - mkdir: /builds/slave/test/build/tests 07:14:40 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')]} 07:14:40 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:14:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:14:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:14:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:14:43 INFO - Downloaded 1361 bytes. 07:14:43 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:14:43 INFO - Using the following test package requirements: 07:14:43 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:43 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:14:43 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:14:43 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:43 INFO - u'jsshell-linux-x86_64.zip'], 07:14:43 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:14:43 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:14:43 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:14:43 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:14:43 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:14:43 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:14:43 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:14:43 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:43 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:14:44 INFO - Downloaded 23895261 bytes. 07:14:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:14:46 INFO - Return code: 0 07:14:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:14:46 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')]} 07:14:46 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:14:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:14:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:14:54 INFO - Downloaded 23895261 bytes. 07:14:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:14:55 INFO - Return code: 0 07:14: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')]} 07:14:55 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:14:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:14:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:14:57 INFO - Downloaded 10840152 bytes. 07:14:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:14:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:14:57 INFO - Return code: 0 07:14:57 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')]} 07:14:57 INFO - https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:14:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:14:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:14:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:14:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:15:02 INFO - Downloaded 58442478 bytes. 07:15:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:02 INFO - mkdir: /builds/slave/test/properties 07:15:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:02 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:02 INFO - Contents: 07:15:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:15:03 INFO - Running post-action listener: _resource_record_post_action 07:15:03 INFO - Running post-action listener: set_extra_try_arguments 07:15:03 INFO - ##### 07:15:03 INFO - ##### Finished download-and-extract step (success) 07:15:03 INFO - ##### 07:15:03 INFO - ##### 07:15:03 INFO - ##### Running populate-webroot step. 07:15:03 INFO - ##### 07:15:03 INFO - Running pre-action listener: _resource_record_pre_action 07:15:03 INFO - Running main action method: populate_webroot 07:15:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:03 INFO - '--tppagecycles', 07:15:03 INFO - '7'], 07:15:03 INFO - 'tests': ['tsvgm']}}, 07:15:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:03 INFO - 'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:03 INFO - 'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['damp', 'tps']}, 07:15:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:03 INFO - 'tests': ['damp', 'tps']}, 07:15:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['dromaeo_dom']}, 07:15:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['a11yr', 07:15:03 INFO - 'ts_paint', 07:15:03 INFO - 'tpaint', 07:15:03 INFO - 'sessionrestore', 07:15:03 INFO - 'sessionrestore_no_auto_restore', 07:15:03 INFO - 'tabpaint']}, 07:15:03 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:03 INFO - 'ts_paint', 07:15:03 INFO - 'tpaint', 07:15:03 INFO - 'sessionrestore', 07:15:03 INFO - 'sessionrestore_no_auto_restore', 07:15:03 INFO - 'tabpaint']}, 07:15:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:03 INFO - 'ts_paint', 07:15:03 INFO - 'tpaint', 07:15:03 INFO - 'sessionrestore', 07:15:03 INFO - 'sessionrestore_no_auto_restore', 07:15:03 INFO - 'tabpaint']}, 07:15:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:03 INFO - 'ts_paint', 07:15:03 INFO - 'tpaint', 07:15:03 INFO - 'sessionrestore', 07:15:03 INFO - 'sessionrestore_no_auto_restore', 07:15:03 INFO - 'tabpaint']}, 07:15:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['a11yr', 07:15:03 INFO - 'ts_paint', 07:15:03 INFO - 'tpaint', 07:15:03 INFO - 'sessionrestore', 07:15:03 INFO - 'sessionrestore_no_auto_restore', 07:15:03 INFO - 'tabpaint']}, 07:15:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['a11yr', 07:15:03 INFO - 'ts_paint', 07:15:03 INFO - 'tpaint', 07:15:03 INFO - 'sessionrestore', 07:15:03 INFO - 'sessionrestore_no_auto_restore', 07:15:03 INFO - 'tabpaint']}, 07:15:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['tsvgx', 07:15:03 INFO - 'tsvgr_opacity', 07:15:03 INFO - 'tart', 07:15:03 INFO - 'tscrollx', 07:15:03 INFO - 'cart']}, 07:15:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:03 INFO - 'tsvgr_opacity', 07:15:03 INFO - 'tart', 07:15:03 INFO - 'tscrollx', 07:15:03 INFO - 'cart']}, 07:15:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:03 INFO - 'talos_options': ['--disable-e10s'], 07:15:03 INFO - 'tests': ['tp5o']}, 07:15:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:03 INFO - 'tests': ['tp5o']}, 07:15:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:03 INFO - 'talos_options': ['--disable-e10s', 07:15:03 INFO - '--xperf_path', 07:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:03 INFO - 'tests': ['tp5n']}, 07:15:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:15:03 INFO - 'talos_options': ['--xperf_path', 07:15:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:03 INFO - 'tests': ['tp5n']}}, 07:15:03 INFO - 'talos.zip': {'path': '', 07:15:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:03 INFO - Running post-action listener: _resource_record_post_action 07:15:03 INFO - ##### 07:15:03 INFO - ##### Finished populate-webroot step (success) 07:15:03 INFO - ##### 07:15:03 INFO - ##### 07:15:03 INFO - ##### Running create-virtualenv step. 07:15:03 INFO - ##### 07:15:03 INFO - Running pre-action listener: _resource_record_pre_action 07:15:03 INFO - Running main action method: create_virtualenv 07:15:03 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:03 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 07:15:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:03 INFO - Using real prefix '/usr' 07:15:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:03 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:05 INFO - Installing pip.................done. 07:15:05 INFO - Return code: 0 07:15:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:05 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 0x7f67df651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, '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': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', '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 07:15:05 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 07:15:05 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 07:15:05 INFO - Using env: {'DISPLAY': ':0', 07:15:05 INFO - 'HOME': '/home/cltbld', 07:15:05 INFO - 'LANG': 'en_US.UTF-8', 07:15:05 INFO - 'LANGUAGE': 'en_US:en', 07:15:05 INFO - 'LOGNAME': 'cltbld', 07:15:05 INFO - 'MAIL': '/var/mail/cltbld', 07:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:05 INFO - 'MOZ_NO_REMOTE': '1', 07:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:05 INFO - 'NO_EM_RESTART': '1', 07:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:05 INFO - 'PWD': '/builds/slave/test', 07:15:05 INFO - 'SHELL': '/bin/bash', 07:15:05 INFO - 'SHLVL': '1', 07:15:05 INFO - 'TERM': 'linux', 07:15:05 INFO - 'TMOUT': '86400', 07:15:05 INFO - 'USER': 'cltbld', 07:15:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:05 INFO - '_': '/tools/buildbot/bin/python'} 07:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:05 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 07:15:05 INFO - Cleaning up... 07:15:05 INFO - Return code: 0 07:15:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:05 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 0x7f67df651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, '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': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', '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 07:15:05 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 07:15:05 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 07:15:05 INFO - Using env: {'DISPLAY': ':0', 07:15:05 INFO - 'HOME': '/home/cltbld', 07:15:05 INFO - 'LANG': 'en_US.UTF-8', 07:15:05 INFO - 'LANGUAGE': 'en_US:en', 07:15:05 INFO - 'LOGNAME': 'cltbld', 07:15:05 INFO - 'MAIL': '/var/mail/cltbld', 07:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:05 INFO - 'MOZ_NO_REMOTE': '1', 07:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:05 INFO - 'NO_EM_RESTART': '1', 07:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:05 INFO - 'PWD': '/builds/slave/test', 07:15:05 INFO - 'SHELL': '/bin/bash', 07:15:05 INFO - 'SHLVL': '1', 07:15:05 INFO - 'TERM': 'linux', 07:15:05 INFO - 'TMOUT': '86400', 07:15:05 INFO - 'USER': 'cltbld', 07:15:05 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:05 INFO - '_': '/tools/buildbot/bin/python'} 07:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:06 INFO - Downloading/unpacking psutil>=0.7.1 07:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:08 INFO - Installing collected packages: psutil 07:15:08 INFO - Running setup.py install for psutil 07:15:08 INFO - building 'psutil._psutil_linux' extension 07:15:08 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 07:15:08 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 07:15:08 INFO - building 'psutil._psutil_posix' extension 07:15:08 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 07:15:08 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 07:15:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:08 INFO - Successfully installed psutil 07:15:08 INFO - Cleaning up... 07:15:08 INFO - Return code: 0 07:15:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:15:08 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')]} 07:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:08 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')]} 07:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:08 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 0x7f67df651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, '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': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', '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 07:15:08 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 07:15:08 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 07:15:08 INFO - Using env: {'DISPLAY': ':0', 07:15:08 INFO - 'HOME': '/home/cltbld', 07:15:08 INFO - 'LANG': 'en_US.UTF-8', 07:15:08 INFO - 'LANGUAGE': 'en_US:en', 07:15:08 INFO - 'LOGNAME': 'cltbld', 07:15:08 INFO - 'MAIL': '/var/mail/cltbld', 07:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:08 INFO - 'MOZ_NO_REMOTE': '1', 07:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:08 INFO - 'NO_EM_RESTART': '1', 07:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:08 INFO - 'PWD': '/builds/slave/test', 07:15:08 INFO - 'SHELL': '/bin/bash', 07:15:08 INFO - 'SHLVL': '1', 07:15:08 INFO - 'TERM': 'linux', 07:15:08 INFO - 'TMOUT': '86400', 07:15:08 INFO - 'USER': 'cltbld', 07:15:08 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:08 INFO - '_': '/tools/buildbot/bin/python'} 07:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:15:10 INFO - Installing collected packages: mozsystemmonitor 07:15:10 INFO - Running setup.py install for mozsystemmonitor 07:15:10 INFO - Successfully installed mozsystemmonitor 07:15:10 INFO - Cleaning up... 07:15:10 INFO - Return code: 0 07:15:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:10 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 0x7f67df651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, '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': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', '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 07:15:10 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 07:15:10 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 07:15:10 INFO - Using env: {'DISPLAY': ':0', 07:15:10 INFO - 'HOME': '/home/cltbld', 07:15:10 INFO - 'LANG': 'en_US.UTF-8', 07:15:10 INFO - 'LANGUAGE': 'en_US:en', 07:15:10 INFO - 'LOGNAME': 'cltbld', 07:15:10 INFO - 'MAIL': '/var/mail/cltbld', 07:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:10 INFO - 'MOZ_NO_REMOTE': '1', 07:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:10 INFO - 'NO_EM_RESTART': '1', 07:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:10 INFO - 'PWD': '/builds/slave/test', 07:15:10 INFO - 'SHELL': '/bin/bash', 07:15:10 INFO - 'SHLVL': '1', 07:15:10 INFO - 'TERM': 'linux', 07:15:10 INFO - 'TMOUT': '86400', 07:15:10 INFO - 'USER': 'cltbld', 07:15:10 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:10 INFO - '_': '/tools/buildbot/bin/python'} 07:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:11 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:13 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:13 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 07:15:13 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 07:15:13 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 07:15:13 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 07:15:13 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 07:15:13 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 07:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:13 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 07:15:13 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 07:15:13 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 07:15:13 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 07:15:13 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 07:15:13 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 07:15:13 INFO - Downloading docopt-0.6.1.tar.gz 07:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:13 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:13 INFO - Running setup.py install for blobuploader 07:15:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:13 INFO - Running setup.py install for requests 07:15:14 INFO - Running setup.py install for docopt 07:15:14 INFO - Successfully installed blobuploader requests docopt 07:15:14 INFO - Cleaning up... 07:15:14 INFO - Return code: 0 07:15:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:14 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 0x7f67df651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, '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': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', '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 07:15:14 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 07:15:14 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 07:15:14 INFO - Using env: {'DISPLAY': ':0', 07:15:14 INFO - 'HOME': '/home/cltbld', 07:15:14 INFO - 'LANG': 'en_US.UTF-8', 07:15:14 INFO - 'LANGUAGE': 'en_US:en', 07:15:14 INFO - 'LOGNAME': 'cltbld', 07:15:14 INFO - 'MAIL': '/var/mail/cltbld', 07:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:14 INFO - 'MOZ_NO_REMOTE': '1', 07:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:14 INFO - 'NO_EM_RESTART': '1', 07:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:14 INFO - 'PWD': '/builds/slave/test', 07:15:14 INFO - 'SHELL': '/bin/bash', 07:15:14 INFO - 'SHLVL': '1', 07:15:14 INFO - 'TERM': 'linux', 07:15:14 INFO - 'TMOUT': '86400', 07:15:14 INFO - 'USER': 'cltbld', 07:15:14 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:14 INFO - '_': '/tools/buildbot/bin/python'} 07:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:14 INFO - Running setup.py (path:/tmp/pip-WkEHcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:14 INFO - Running setup.py (path:/tmp/pip-CmS5rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:14 INFO - Running setup.py (path:/tmp/pip-FCIzkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:14 INFO - Running setup.py (path:/tmp/pip-7bwnyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:14 INFO - Running setup.py (path:/tmp/pip-vaaNbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:15 INFO - Running setup.py (path:/tmp/pip-H8uBwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:15 INFO - Running setup.py (path:/tmp/pip-WOP2YA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:15 INFO - Running setup.py (path:/tmp/pip-j_ROXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:15 INFO - Running setup.py (path:/tmp/pip-Xjq93u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:15 INFO - Running setup.py (path:/tmp/pip-bWO319-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:15 INFO - Running setup.py (path:/tmp/pip-itb5Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:15 INFO - Running setup.py (path:/tmp/pip-Aqy87R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:15 INFO - Running setup.py (path:/tmp/pip-g1c1kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:15 INFO - Running setup.py (path:/tmp/pip-goOSab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:15 INFO - Running setup.py (path:/tmp/pip-rQnhGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:15 INFO - Running setup.py (path:/tmp/pip-aj1P5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:15 INFO - Running setup.py (path:/tmp/pip-CeMB56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:15 INFO - Running setup.py install for manifestparser 07:15:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:15 INFO - Running setup.py install for mozcrash 07:15:16 INFO - Running setup.py install for mozdebug 07:15:16 INFO - Running setup.py install for mozdevice 07:15:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Running setup.py install for mozfile 07:15:16 INFO - Running setup.py install for mozhttpd 07:15:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Running setup.py install for mozinfo 07:15:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Running setup.py install for mozInstall 07:15:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Running setup.py install for mozleak 07:15:16 INFO - Running setup.py install for mozlog 07:15:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Running setup.py install for moznetwork 07:15:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:16 INFO - Running setup.py install for mozprocess 07:15:17 INFO - Running setup.py install for mozprofile 07:15:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:17 INFO - Running setup.py install for mozrunner 07:15:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:17 INFO - Running setup.py install for mozscreenshot 07:15:17 INFO - Running setup.py install for moztest 07:15:17 INFO - Running setup.py install for mozversion 07:15:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:17 INFO - Cleaning up... 07:15:17 INFO - Return code: 0 07:15:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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')]} 07:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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')]} 07:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:17 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 0x7f67df651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, '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': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', '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 07:15:17 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 07:15:17 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 07:15:17 INFO - Using env: {'DISPLAY': ':0', 07:15:17 INFO - 'HOME': '/home/cltbld', 07:15:17 INFO - 'LANG': 'en_US.UTF-8', 07:15:17 INFO - 'LANGUAGE': 'en_US:en', 07:15:17 INFO - 'LOGNAME': 'cltbld', 07:15:17 INFO - 'MAIL': '/var/mail/cltbld', 07:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:17 INFO - 'MOZ_NO_REMOTE': '1', 07:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:17 INFO - 'NO_EM_RESTART': '1', 07:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:17 INFO - 'PWD': '/builds/slave/test', 07:15:17 INFO - 'SHELL': '/bin/bash', 07:15:17 INFO - 'SHLVL': '1', 07:15:17 INFO - 'TERM': 'linux', 07:15:17 INFO - 'TMOUT': '86400', 07:15:17 INFO - 'USER': 'cltbld', 07:15:17 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:17 INFO - '_': '/tools/buildbot/bin/python'} 07:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:17 INFO - Running setup.py (path:/tmp/pip-JXWcnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:17 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)) 07:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:17 INFO - Running setup.py (path:/tmp/pip-Pkkk97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:18 INFO - Running setup.py (path:/tmp/pip-6sG3qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:18 INFO - Running setup.py (path:/tmp/pip-G0BlJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:18 INFO - Running setup.py (path:/tmp/pip-WFq9mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:18 INFO - Running setup.py (path:/tmp/pip-oUv1TG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:18 INFO - Running setup.py (path:/tmp/pip-2hEMyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:18 INFO - Running setup.py (path:/tmp/pip-bCSFG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:18 INFO - Running setup.py (path:/tmp/pip-RS9rqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:18 INFO - Running setup.py (path:/tmp/pip-eWIjPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:18 INFO - Running setup.py (path:/tmp/pip-QFLKqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:18 INFO - Running setup.py (path:/tmp/pip-MuA_oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:18 INFO - Running setup.py (path:/tmp/pip-lOMx4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:18 INFO - Running setup.py (path:/tmp/pip-qvHPlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:18 INFO - Running setup.py (path:/tmp/pip-Cu2PTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:18 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)) 07:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:18 INFO - Running setup.py (path:/tmp/pip-zYGY_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:19 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)) 07:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:19 INFO - Running setup.py (path:/tmp/pip-M1IVcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:19 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)) 07:15:19 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)) 07:15:19 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)) 07:15:19 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)) 07:15:19 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)) 07:15:19 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)) 07:15:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:20 INFO - Downloading blessings-1.6.tar.gz 07:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:21 INFO - Installing collected packages: blessings 07:15:21 INFO - Running setup.py install for blessings 07:15:21 INFO - Successfully installed blessings 07:15:21 INFO - Cleaning up... 07:15:21 INFO - Return code: 0 07:15:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:21 INFO - Reading from file tmpfile_stdout 07:15:21 INFO - Current package versions: 07:15:21 INFO - argparse == 1.2.1 07:15:21 INFO - blessings == 1.6 07:15:21 INFO - blobuploader == 1.2.4 07:15:21 INFO - docopt == 0.6.1 07:15:21 INFO - manifestparser == 1.1 07:15:21 INFO - mozInstall == 1.12 07:15:21 INFO - mozcrash == 0.17 07:15:21 INFO - mozdebug == 0.1 07:15:21 INFO - mozdevice == 0.48 07:15:21 INFO - mozfile == 1.2 07:15:21 INFO - mozhttpd == 0.7 07:15:21 INFO - mozinfo == 0.9 07:15:21 INFO - mozleak == 0.1 07:15:21 INFO - mozlog == 3.1 07:15:21 INFO - moznetwork == 0.27 07:15:21 INFO - mozprocess == 0.22 07:15:21 INFO - mozprofile == 0.28 07:15:21 INFO - mozrunner == 6.11 07:15:21 INFO - mozscreenshot == 0.1 07:15:21 INFO - mozsystemmonitor == 0.0 07:15:21 INFO - moztest == 0.7 07:15:21 INFO - mozversion == 1.4 07:15:21 INFO - psutil == 3.1.1 07:15:21 INFO - requests == 1.2.3 07:15:21 INFO - wsgiref == 0.1.2 07:15:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:21 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 0x7f67df651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, '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': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', '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 07:15:21 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 07:15:21 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 07:15:21 INFO - Using env: {'DISPLAY': ':0', 07:15:21 INFO - 'HOME': '/home/cltbld', 07:15:21 INFO - 'LANG': 'en_US.UTF-8', 07:15:21 INFO - 'LANGUAGE': 'en_US:en', 07:15:21 INFO - 'LOGNAME': 'cltbld', 07:15:21 INFO - 'MAIL': '/var/mail/cltbld', 07:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:21 INFO - 'MOZ_NO_REMOTE': '1', 07:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:21 INFO - 'NO_EM_RESTART': '1', 07:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:21 INFO - 'PWD': '/builds/slave/test', 07:15:21 INFO - 'SHELL': '/bin/bash', 07:15:21 INFO - 'SHLVL': '1', 07:15:21 INFO - 'TERM': 'linux', 07:15:21 INFO - 'TMOUT': '86400', 07:15:21 INFO - 'USER': 'cltbld', 07:15:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:21 INFO - '_': '/tools/buildbot/bin/python'} 07:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:21 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)) 07:15:21 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)) 07:15:21 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)) 07:15:21 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)) 07:15:21 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)) 07:15:21 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)) 07:15:21 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)) 07:15:21 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)) 07:15:21 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)) 07:15:21 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)) 07:15:21 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)) 07:15:21 INFO - Cleaning up... 07:15:21 INFO - Return code: 0 07:15:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:21 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 0x7f67df651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, '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': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', '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 07:15:21 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 07:15:21 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 07:15:21 INFO - Using env: {'DISPLAY': ':0', 07:15:21 INFO - 'HOME': '/home/cltbld', 07:15:21 INFO - 'LANG': 'en_US.UTF-8', 07:15:21 INFO - 'LANGUAGE': 'en_US:en', 07:15:21 INFO - 'LOGNAME': 'cltbld', 07:15:21 INFO - 'MAIL': '/var/mail/cltbld', 07:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:21 INFO - 'MOZ_NO_REMOTE': '1', 07:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:21 INFO - 'NO_EM_RESTART': '1', 07:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:21 INFO - 'PWD': '/builds/slave/test', 07:15:21 INFO - 'SHELL': '/bin/bash', 07:15:21 INFO - 'SHLVL': '1', 07:15:21 INFO - 'TERM': 'linux', 07:15:21 INFO - 'TMOUT': '86400', 07:15:21 INFO - 'USER': 'cltbld', 07:15:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:21 INFO - '_': '/tools/buildbot/bin/python'} 07:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:21 INFO - Downloading/unpacking jsonschema 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15: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 07:15:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:23 INFO - Downloading/unpacking functools32 (from jsonschema) 07:15:23 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 07:15:23 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 07:15:23 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 07:15:23 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 07:15:23 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 07:15:23 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 07:15:23 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:24 INFO - warning: no files found matching '*.txt' 07:15:24 INFO - no previously-included directories found matching 'build' 07:15:24 INFO - no previously-included directories found matching 'dist' 07:15:24 INFO - no previously-included directories found matching '.git*' 07:15:24 INFO - Installing collected packages: jsonschema, functools32 07:15:24 INFO - Running setup.py install for functools32 07:15:24 INFO - warning: no files found matching '*.txt' 07:15:24 INFO - no previously-included directories found matching 'build' 07:15:24 INFO - no previously-included directories found matching 'dist' 07:15:24 INFO - no previously-included directories found matching '.git*' 07:15:24 INFO - Successfully installed jsonschema functools32 07:15:24 INFO - Cleaning up... 07:15:24 INFO - Return code: 0 07:15:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:15:24 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')]} 07:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:24 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')]} 07:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:24 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 0x7f67df651f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a13770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, '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': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', '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 07:15:24 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 07:15:24 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 07:15:24 INFO - Using env: {'DISPLAY': ':0', 07:15:24 INFO - 'HOME': '/home/cltbld', 07:15:24 INFO - 'LANG': 'en_US.UTF-8', 07:15:24 INFO - 'LANGUAGE': 'en_US:en', 07:15:24 INFO - 'LOGNAME': 'cltbld', 07:15:24 INFO - 'MAIL': '/var/mail/cltbld', 07:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:24 INFO - 'MOZ_NO_REMOTE': '1', 07:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:24 INFO - 'NO_EM_RESTART': '1', 07:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:24 INFO - 'PWD': '/builds/slave/test', 07:15:24 INFO - 'SHELL': '/bin/bash', 07:15:24 INFO - 'SHLVL': '1', 07:15:24 INFO - 'TERM': 'linux', 07:15:24 INFO - 'TMOUT': '86400', 07:15:24 INFO - 'USER': 'cltbld', 07:15:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:24 INFO - '_': '/tools/buildbot/bin/python'} 07:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:24 INFO - Downloading/unpacking flake8 07:15:24 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 07:15:24 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 07:15:24 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 07:15:24 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 07:15:24 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 07:15:24 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 07:15:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:15:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:15:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 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 07:15:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:15:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:27 INFO - no previously-included directories found matching 'docs/_build' 07:15:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:15:27 INFO - Running setup.py install for pep8 07:15:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:15:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:15:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:15:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:15:27 INFO - no previously-included directories found matching 'docs/_build' 07:15:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:15:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:15:27 INFO - Cleaning up... 07:15:27 INFO - Return code: 0 07:15:27 INFO - Running post-action listener: _resource_record_post_action 07:15:27 INFO - Running post-action listener: _start_resource_monitoring 07:15:27 INFO - Starting resource monitoring. 07:15:27 INFO - ##### 07:15:27 INFO - ##### Finished create-virtualenv step (success) 07:15:27 INFO - ##### 07:15:27 INFO - ##### 07:15:27 INFO - ##### Running install step. 07:15:27 INFO - ##### 07:15:27 INFO - Running pre-action listener: _resource_record_pre_action 07:15:27 INFO - Running main action method: install 07:15:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:27 INFO - Reading from file tmpfile_stdout 07:15:27 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:27 INFO - Reading from file tmpfile_stdout 07:15:27 INFO - Output received: 07:15:27 INFO - Usage: mozinstall [options] installer 07:15:27 INFO - Options: 07:15:27 INFO - -h, --help show this help message and exit 07:15:27 INFO - -d DEST, --destination=DEST 07:15:27 INFO - Directory to install application into. [default: 07:15:27 INFO - "/builds/slave/test"] 07:15:27 INFO - --app=APP Application being installed. [default: firefox] 07:15:27 INFO - mkdir: /builds/slave/test/build/application 07:15:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:15:44 INFO - Reading from file tmpfile_stdout 07:15:44 INFO - Output received: 07:15:44 INFO - /builds/slave/test/build/application/firefox/firefox 07:15:44 INFO - Running post-action listener: _resource_record_post_action 07:15:44 INFO - ##### 07:15:44 INFO - ##### Finished install step (success) 07:15:44 INFO - ##### 07:15:44 INFO - ##### 07:15:44 INFO - ##### Running run-tests step. 07:15:44 INFO - ##### 07:15:44 INFO - Running pre-action listener: _resource_record_pre_action 07:15:44 INFO - Running main action method: run_tests 07:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:44 INFO - Python 2.7.3 07:15:44 INFO - Return code: 0 07:15:44 INFO - grabbing minidump binary from tooltool 07:15:44 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')]} 07:15:44 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 0x1aa29c0>, '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 0x1aa38c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3d50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:44 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 07:15:44 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 07:15:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:44 INFO - Return code: 0 07:15:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:15:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:15:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:15:45 INFO - Return code: 0 07:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 07:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 07:15:45 INFO - Using env: {'DISPLAY': ':0', 07:15:45 INFO - 'HOME': '/home/cltbld', 07:15:45 INFO - 'LANG': 'en_US.UTF-8', 07:15:45 INFO - 'LANGUAGE': 'en_US:en', 07:15:45 INFO - 'LOGNAME': 'cltbld', 07:15:45 INFO - 'MAIL': '/var/mail/cltbld', 07:15:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:45 INFO - 'MOZ_NO_REMOTE': '1', 07:15:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:45 INFO - 'NO_EM_RESTART': '1', 07:15:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:45 INFO - 'PWD': '/builds/slave/test', 07:15:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:45 INFO - 'SHELL': '/bin/bash', 07:15:45 INFO - 'SHLVL': '1', 07:15:45 INFO - 'TERM': 'linux', 07:15:45 INFO - 'TMOUT': '86400', 07:15:45 INFO - 'USER': 'cltbld', 07:15:45 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1462803224.304042-1463327556', 07:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:45 INFO - '_': '/tools/buildbot/bin/python'} 07:15:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 07:15:45 INFO - mozversion application_buildid: 20160509040557 07:15:45 INFO - mozversion application_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 07:15:45 INFO - mozversion application_display_name: Nightly 07:15:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:45 INFO - mozversion application_name: Firefox 07:15:45 INFO - mozversion application_remotingname: firefox 07:15:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:15:45 INFO - mozversion application_vendor: Mozilla 07:15:45 INFO - mozversion application_version: 49.0a1 07:15:45 INFO - mozversion platform_buildid: 20160509040557 07:15:45 INFO - mozversion platform_changeset: 043082cb7bd8490c60815f67fbd1f33323ad7663 07:15:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:15:45 INFO - mozversion platform_version: 49.0a1 07:15:45 INFO - using testdate: 1462803345 07:15:45 INFO - actual date: 1462803345 07:15:45 INFO - starting webserver on 'localhost:44218' 07:15:45 INFO - SUITE-START | Running 2 tests 07:15:45 INFO - TEST-START | dromaeo_css 07:15:45 INFO - operating with platform_type : linux_ 07:15:45 INFO - Initialising browser for dromaeo_css test... 07:15:45 INFO - TEST-INFO | started process 11348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAgM1Us/profile http://localhost:44218/getInfo.html) 07:15:50 INFO - PROCESS | 11348 | __metrics Screen width/height:1600/1200 07:15:50 INFO - PROCESS | 11348 | colorDepth:24 07:15:50 INFO - PROCESS | 11348 | Browser inner width/height: 1024/697 07:15:50 INFO - PROCESS | 11348 | __metrics 07:15:52 ERROR - PROCESS | 11348 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:15:53 INFO - TEST-INFO | 11348: exit 0 07:15:53 INFO - Browser initialized. 07:15:53 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:53 INFO - TEST-INFO | started process 11430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAgM1Us/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:05 INFO - PROCESS | 11430 | RSS: Main: 152023040 07:16:05 INFO - PROCESS | 11430 | 07:16:56 INFO - PROCESS | 11430 | 1462803416517 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] 07:19:04 INFO - PROCESS | 11430 | Cycle 1(1): loaded http://localhost:44218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44218/tests/dromaeo/cssquery-ext.html) 07:19:05 INFO - PROCESS | 11430 | RSS: Main: 265363456 07:19:05 INFO - PROCESS | 11430 | 07:22:08 INFO - PROCESS | 11430 | Cycle 1(1): loaded http://localhost:44218/tests/dromaeo/cssquery-ext.html (next: http://localhost:44218/tests/dromaeo/cssquery-jquery.html) 07:22:08 INFO - PROCESS | 11430 | RSS: Main: 232001536 07:22:08 INFO - PROCESS | 11430 | 07:25:10 INFO - PROCESS | 11430 | Cycle 1(1): loaded http://localhost:44218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44218/tests/dromaeo/cssquery-mootools.html) 07:25:11 INFO - PROCESS | 11430 | RSS: Main: 237363200 07:25:11 INFO - PROCESS | 11430 | 07:28:13 INFO - PROCESS | 11430 | Cycle 1(1): loaded http://localhost:44218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44218/tests/dromaeo/cssquery-prototype.html) 07:28:13 INFO - PROCESS | 11430 | RSS: Main: 228216832 07:28:13 INFO - PROCESS | 11430 | 07:31:16 INFO - PROCESS | 11430 | Cycle 1(1): loaded http://localhost:44218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44218/tests/dromaeo/cssquery-yui.html) 07:31:16 INFO - PROCESS | 11430 | RSS: Main: 197640192 07:31:16 INFO - PROCESS | 11430 | 07:34:19 INFO - PROCESS | 11430 | Cycle 1(1): loaded http://localhost:44218/tests/dromaeo/cssquery-yui.html (next: http://localhost:44218/tests/dromaeo/cssquery-dojo.html) 07:34:19 INFO - PROCESS | 11430 | RSS: Main: 261693440 07:34:19 INFO - PROCESS | 11430 | 07:34:19 INFO - PROCESS | 11430 | __start_tp_report 07:34:19 INFO - PROCESS | 11430 | _x_x_mozilla_page_load 07:34:19 INFO - PROCESS | 11430 | _x_x_mozilla_page_load_details 07:34:19 INFO - PROCESS | 11430 | |i|pagename|runs| 07:34:19 INFO - PROCESS | 11430 | |0;dojo.html;3170.9048728538137;3183.538386933895;3193.6007999000117;3222.7744057915957;3243.6756324367566;5265.420803711599;5371.274877891484;5391.676499410039;5523.281973343464;5552.944470555293;5381.892362152755;5385;5410.242566040757;5449.6730196188255;5480.9177862332;4785;4807.543283388072;4944.233643785219;5018.473060328668;5028.723420211887;4999.700017998914;5008.048470790556;5062.772175252123;5078.847634570969;5084.745762711868;4802.03959208158;4841.225403935354;4841.3222148899185;4853.660243782937;4943.505649435064;4842.467328593852;4900.607951363918;4979.278004689336;4998.650094493387;5024.497550244946;4761.500042495557;4929.926051109236;4964.106460837048;4967.230079337708;5030;5332.120200167006;5360.91958620621;5424.105022671254;5502.972485137549;5506.366767821672;5877.735501902382;5897.911531327033;5938.465538101592;5941.762329506858;5964.0457526795935;5684.516816070639;5713.74288157034;5760.8271751847515;5969.611975221596;5975;5486.1222204447095;5489.34127904654;5499.835004949858;5507.9449205507835;5511.338639363262;5943.31651860033;5948.762049518057;5958.165856779968;5958.404159584094;5966.433188847052;5493.752781124859;5690;5715.799947001835;5735.627184233012;5752.9712351437975;5862.355140934494;5863.648181109147;5866.208061911672;5904.852378690567;5919.289685237799;5831.3877042910735;5843.444872737083;5858.297004359419;5859.44335288147;5860.970695146582;5556.249906262684;5721.713914304268;5728.169415434739;5767.653940763484;5832.1834943108;4398.912021759611;4411;4414.3157810539415;4416.823327066882;4452.910941781146;3805.9429108563395;3930.5283365996265;3937.822797974098;3956.9010774730864;3959.4852669152824;5361.329833770778;5367.221752845816;5418.512333889968;5439.755211015514;5440.102383106822;5779.797707080232;5821.679807610622;5827.7668893244645;5829.795957141479;5832.066869300891;5293.788248470018;5399.541039011649;5446.128619420953;5446.91829622556;5447.428020057916;4982.60139188864;5006.224035274466;5007.6494645375205;5027.421846487628;5036.370453693288;5903.557233207526;5906.40935906406;5911.083782013795;5932.139839723302;5979.491743201789;5668.37647858727;5744.4829965303325;5781.075027995669;5783.884322313615;5849.502792262535;5897.292324921037;5897.941020589739;5900.380460051632;5900.675462849585;5904.291485021825;5703.144528320785;5723.5707321950185;5727.6849773262875;5728.484436400578;5731.627444216113;5667.149927510742;5775.249217601853;5791.362950075572;5807.622504537191;5840.153177789111;5692.1461780733225;5693.430656934273;5703.4296570344295;5703.686297253525;5706.6005379624685;5544.445555444423;5635.605507614428;5672.546196304368;5685.545156387562;5691;5489.945100548944;5517.144842549411;5554.583406244628;5573.888522229614;5589.329280486368;5718.228039214653;5746.080627099644;5802.216700745345;5813.563982701399;5828.125781132864;5458.8908221834545;5540.584456165723;5637.098064309691;5646.661200327993;5686.289213848269 07:34:19 INFO - PROCESS | 11430 | |1;ext.html;597.5458651424916;633.6071635585936;642.3127253838395;651.9445847102996;658.7068754404291;43266.78366608167;44775;44964.32553511692;44964.550354496445;49172.754136229356;45947;46131.308030379485;46323.53676463234;46405.07189856201;46502;8919.687810926602;9066.909330906705;9068.410553314046;9076.41003334781;9076.682316118937;8890.73327800167;8982.236509896667;8987.595558199897;8989.685361012365;8992.100789920989;9014.36899417041;9026.187643112118;9055.683051093212;9059.229965452945;9065.59204835784;8919.063498332678;8980.146886045848;9023.458592484472;9036.412633178856;9043.231325337289;8837.779055523599;8903.821923561558;8911.064338244521;8912;8912.24245939096;42138.57861421377;42464.78767606142;42515.14969700589;42570.36144457835;42664.36003459951;3238.87044518219;3407.505911642823;3411.1131105912395;3436.4845273209216;3451.6548345165534;32053.1986700332;32104.83947580247;32643.18392040194;33210.33579328424;33237.16907077318;4365.607095361433;4394.648428125743;4417.823287068513;4445.288753799409;4447.310666846644;303425;304524;304736;306176;306630;58508.82982340329;58699;58895;58948.41051589515;58995.41004589899;36794.08014799598;38200;62354;62418.687906561085;62474.68762656249;16309.102999335151;16430.75353869669;16431.342746290014;16453;16486.83513164877;12371;12521.686957825945;12530.185537940004;12548.372581371077;12564.120511564102;19854.90072549628;19934.30229941945;20234;20253.08861101254;20331.255280537232;7168.247334029956;7243.7464688735645;7357.264273572707;7497.812554686177;7586.696532138763;1004.3923426327113;1009.5255230041869;1059.0098258128521;1138.6754774889116;1166.055495049013;31822.522662160085;32350.83824580862;32617;32842.50736238958;33326;1163.139276935062;1216.4586758892208;1225.7732319520917;1240.8883200511998;1258.0690289185936;17278.568035799206;17544.385946491813;17722.5569360767;17744.33092449539;17793;480093;788769;803256;804147;804254;60336;60537.69731151404;60838;60923.390766092656;60932.69533652392;1280.21266920843;1384.9307534623229;1385.3835043405588;1427.5931359562476;1443.8483959184134;29159;32775.34449310953;33189.83405082959;33256.66743332632;33790.49314260239;50379.496205038944;50671.2399314018;51169.744151279;51173;51181.48818511916;366749;369942;370208;370403;370615;23112.537749244584;27727.44545109127;28672.85663571669;28741.712582873904;29102;48238.75880620575;48270.275945860136;48375.75812121058;48486.75756621194;48572;40857.1828563433;41286.79356603198;41333.1733365325;41789;42622;39667.40498892461;40641;40771.1845763089;41608;41875;36071.27857442889;40647;41134.382984255855;41864.58135418607;44114.33828492511;34649.82675086609;36150.27699446049;36443.27113457769;36638.267234655694;36985.81507092447;27924.441511169258;27957.301067473476;28149.71850281471;28203.43593128085;28364.432711345245 07:34:19 INFO - PROCESS | 11430 | |2;jquery.html;408.47103001612913;410.4336016297511;411.5493534579635;412.13040484577516;424.71968500789484;13163.670908227276;17786.91106544467;18863.245470181177;19295.710564341545;19297.71053434198;18141.90929045353;18351.98128205896;18737.15682794274;19088.80911190888;19094.904525477352;5679.659220446766;5767.33675627304;5796.565257605696;5805.970970145165;5859.970700146493;5745.770169193227;5760.942390576082;5776.277965254343;5779.682117483537;5811.593188476808;4165.458490396244;4351.434313539251;4780.784864681098;6379.936200638004;6386.042093685938;6179.289381721114;6379.23449186096;6406.487481001532;6495.382938620847;6506.869862602769;5559.9444005559835;5570.192322113271;5590.748416321276;5612.410696876851;5612.7754889804355;20490.692639610417;21771.67342489864;22556.66165007526;23404.414889627726;23444;2266.92065777697;2306.1928325086255;2354.1878052072007;2752.8348299101917;2889.537673972154;9167;9323.860142097874;10143.746406339827;10149.949250253701;10223.539940702687;1796.5329014456336;1803.7835459744915;1819.2813838533837;1866.56135808085;1910.0640686063869;79241.20758792396;80149.59925200394;83139;84927;85533;10152.238582106223;10308.433036183082;10749.193810464247;10921.890781092246;11681.649550513499;15239.161846098572;15326.693466130615;15332.31004604773;15333.846661533466;15508.379664813507;7360.227176146427;7586.62066896664;7637.541747495168;7720.498167619086;7757.224277572198;7059.6117213552725;7084.92915070853;7195.13658361;7267.273272672796;7271.67277472515;4517;4662.207424737802;4698.95301046992;4726.480087190406;4778.904421911612;1875.5217419557925;1900.942971710851;1923.9422817315503;1927.681932481125;1950.5611237471455;947.9573419196153;987.195435719886;1014.2595904989251;1039.2777019971047;1077.5474300793528;18499.722504162448;18522.166502507418;19188.13653385601;19292.517687057934;19367.80632193688;927.4945154890601;974.2644303550916;987.4914419074182;992.1467537917385;1007.6926537406162;10438.478076096164;10729.9463502682;10805.189610779065;10858.72853178661;10890.074343680717;512426.25442473573;514966;526735;547153;563907;92068;93204.53397733104;96601;97165.5141724301;97600;1002.4787110702393;1014.91373233276;1024.9641262555924;1031.4945676618404;1032.318669678009;15614.609634758768;16702.66594668124;16831.41090061842;16909;17156.227969741143;31832.204194895312;32996.34007319792;36999.630003700695;37676.43485347777;38990.220195595364;53819.19271211013;53977.19034214569;55211;56024.15963760465;56151.157732633226;8767.956160219159;8772.429792063496;8809.515476648847;8885.777855553662;9072.183503484717;9850.753731156778;13061.281629510468;13306.86693133095;13343.66640833948;13557.728845422838;5952.76188952437;8152.796180095545;11523.423828808358;11836.881631183922;11922.284662920252;8659.740207793777;11145.331280123219;11287.379194144072;11368.54525818958;11559.422028898689;12001.63995080149;12008.39958002114;12206.267623942593;12305.446254918372;12337.383130843602;7470.4770666052855;7821.491603046012;7881.763547093597;8257.669693212205;9025.729228123168;11929.656609775524;12286.569970051005;12293.323867187391;12315.93842030784;12326.198797078161 07:34:19 INFO - PROCESS | 11430 | |3;mootools.html;1369.8082268482408;1535.9078455292683;1556.0974634711865;1772.9556761080971;1858.5446565591433;8294.62674179662;8719.389642725011;8720.60757265923;8971.102889711026;8978.563429851225;8743.86884196736;8904.73285801427;8926.196642302191;8948.91051089489;8952.239059679934;1940.4372731907729;1997.340877510418;1997.6304383688991;2257.1761307122906;2283.908643654252;2302.343832007878;2384.558856611524;2384.9761502384927;2393.1384701507445;2393.4614711689906;2297.253392647388;2304.2626359564947;2324.337563794319;2324.5467133908896;2350.236173243694;2045.089934978935;2114.4291041418883;2265.63749800032;2297.574948634508;2299.574578702937;2056.979430205694;2239.9328020159423;2315.583195024895;2315.988420057906;2324.3143272734414;8707.521086340248;8755.56222188888;8771.12288771124;8774.166454186841;8781.692640757543;5155.381354237478;5272.841814745564;5277.8416647500635;5303.893922121536;5322.494363035506;3373.662633736631;3405.250844814137;3488.651134886491;3569.8929032129076;3591.2458383739445;1194.3013337197663;1213.83006379107;1222.1506053292965;1234.4259919137644;1258.0753146437453;12564.623061308175;12596.874031259662;12615.873841261653;12619.936900315532;12627;4505.504394516601;4588.632909367243;4631.95368046322;4641.118187544355;4650.441946966318;10383.480825958823;10388.37669739818;10415.791684166274;10425.9478702606;10443;5244.632875698664;5252.29094072303;5255.710935898486;5260.447652996457;5265.341832270966;4236.872893813191;4699.060187962421;4776.2119250324;4805.303231031481;4826.469088400273;4037.858674946363;4050.4126901599693;4100.2414553307735;4123.299039163349;4163.958360416417;1291.1026836348647;1315.7434300311538;1325.8872995795466;1326.0452474218548;1339.6382976596265;818.9099199088096;897.3314880414133;918.1231923513029;921.1617428140494;948.2603569216022;5400.540954018952;5549.861253468614;5771.163181338682;5858.384869588717;5922.170896074467;968.1480297338438;979.7109852593502;985.4333758089127;1002.8417178159237;1007.8337074382645;3732.757370770891;3760.6615404613717;3773.7924414156937;3798.3542797724454;3811.2568049230135;10298.948505257576;10756.19328550362;10876.347419154876;11403.144764142722;11445.969862712229;10954.068904143238;10995.450227488594;10998.890011099948;11147.331160130418;11163.162762792661;8169.305609023299;8226.588670566447;8347.332213423033;8387.832243355098;8421.115782842835;5879.529637628894;5904.970475147768;5931.377205393372;5974.731137098928;6083.6653984029535;10164.847527287244;10201.285909986229;10310.07209351162;10327.070563649308;10402.791944161227;10188.134008609351;10387.324823886423;10452.895471045193;10552.472376381304;10559.366438013743;7175.605341706257;7567.621618919142;7739.845203095794;7826.608669566613;7970.960145199237;8585.227329540372;8591.355648326275;8683.913160868311;8695.434796738191;8715.128487151234;7349.706011759684;7490.887636685563;7498.662560184695;7602.695892164473;7781.805454863674;7314.743983960536;7497.662605182671;7526.849463010819;7655.119661238806;7685.23147685227;6638.17022872141;6664.5334826561675;6702.631355275506;6710.194776626836;6713.697883595152;4691.741954192552;4737.763111844325;4838.8790280241865;4844.128056949783;4884.90230195387;5071.2139618359215;5132.153194722829;5143.202803565453;5172.637915345889;5215.478452154906 07:34:19 INFO - PROCESS | 11430 | |4;prototype.html;320.50642011302597;325.18216685037135;330.5273458953696;332.0685477236353;334.25627977749525;5359.499340184745;5415.346480224691;5416.539594134503;5452.563794896414;5488;5035.194368900977;5079.339685840845;5202.167653175493;5301.1783173608055;5357.678539287645;4132.173565286939;4151.252774500589;4164.854230101947;4173.394857745625;4178.3732440134;4162.354835000565;4171.749695018293;4191.979040104795;4204.117135401554;4210.663146948237;3937.1290939338983;4010.939835902464;4099.364598487239;4119.979400102995;4168.895777605554;4147.232761939051;4163.354680024601;4167.958320416802;4182.602652747984;4183.393407955829;3677.5035370225214;3689.538807649044;3691.464737613058;3693.279810436966;3713.9442908356395;5103.744812759347;5125.3080834087295;5153.3558305211845;5156.92264616031;5232.372115346145;4699.506551812079;4730.976345118287;4735.100330937145;4776;4779.163646361872;5521.895620875801;5524.889502209973;5527.751251193706;5528.391876893538;5555.611107222496;3914.080191155076;3989.4813674222455;3991.1419044905483;3997.4403583498333;4029.5164580250266;5693.946619875336;5745.482906538432;5747.5114615257335;5752.453516915886;5804.65172089676;4047.5952404759287;4055.2092341993616;4066.674666026711;4084.9591504085174;4088.448059511987;4037.152198038386;4129.112240868228;4141.7722025288895;4149.585041495826;4169.3120635094865;4700.177468942989;4712.128256272601;4715.976420117878;4721.268203428474;4734.715917044989;5579.46995035471;5590.903411220792;5606.439356064442;5625.4374562544235;5636.210930469738;1358.381936219018;1395.5952773695717;1399.6181960256906;1402.9929850350684;1405.374608299297;965.8116667249959;979.6424305128577;983.3018556824592;987.9604815807431;992.3103443106971;5230.320058392384;5264.236685680555;5272.420033796279;5284.603654725911;5289.68261904287;5565.638233514808;5573.804916827891;5577.27495425592;5670.121131224667;5678.97160514203;5168.58651307902;5231.764570594332;5262.657927234717;5289.656172348785;5556.77772889088;3009.2476880779805;3041.8935337263088;3045.1778019934936;3064.233941514621;3069.6493542841527;5704;5717.456841600041;5775.249217601685;5812.215350927655;5852.356240813507;5375.6774593524515;5716.628009277827;5739.278216535023;5787.913181302284;5803.448672376117;5738.971305143531;5754.136879468113;5765.394633563499;5810.012297909366;5818.418158184232;5412.594055445936;5677.3754886963225;5715.31416230055;5748.281464816898;5780.5953583248765;5613.803516876889;5615.18579805934;5657.10486986864;5679.914801278067;5697.7151142443545;5783.479486846204;5850.297964244318;5868.67722275279;5869.383714709894;5871.941280587311;3814.218085292564;3827.2345530893376;3909.863154789569;4057.695672824491;4065.593440655911;5658.7082231694585;5737.770489180386;5816.156657284585;5826.941730582809;5836.4028007536235;5611.38274789781;5651.4348565143155;5663.292088488939;5666.34836993751;5687.687177205294;5348.839534813962;5607.158926161109;5643.407442218508;5682.289713785777;5705.22979397776;5475.260839786578;5505.697186654773;5516.889662206813;5517.503424691637;5565.55475561946;5665.575081868794;5681.466004178931;5688.971555142198;5702.37273899879;5730.770769169187;5334.493223143951;5582.692951887523;5583.682771649882;5609.9804070533755;5616.354119276336 07:34:19 INFO - PROCESS | 11430 | |5;yui.html;766.4902839611657;791.7624712586224;875.216681070442;876.9035406105331;902.4089221559881;14166.787498187523;14734.336954837032;14779.408823647042;14816.333265003073;14842.480513182041;13441.32793360333;13450.865491345083;13505.392257348418;13527.594172174826;13531.864681353183;675.2740803636086;689.6034780001519;690.3165865792879;799.0690845165375;812.9187081291853;687.7764726463894;800.9839803203932;821.6713314674148;822.4900561651784;823.9093699693029;865.1521508921229;866.7096522664915;866.9479831210116;870.0690261420283;870.3124531620012;859.6260626627405;868.2923417414787;869.2003356911656;869.326272139094;870.1820288928387;516.2076213013045;526.3026489900897;527.4172039895936;636.7771280051991;637.0794202377566;11626.418679066013;11837.585684501088;11863.169578129535;11961.94019029908;11973;13274.601761947157;13887.652808679763;14134.787978180335;14248.643783905381;14320;11252.43737813106;11274.605388811435;11297.26567773092;11423.086153107732;11703.23928944616;3823.655870971626;3900.5514365848007;3918.7060970427046;3992.3612222044335;4023.4568333274924;51553;51605.22592161121;53950.46049539494;54331.18503222415;54456.727716361165;11151.275167114112;11259.887401126047;11342.489587968561;11437.771244575228;11442;19600.411987640393;19797.802021979885;19881.105350259273;19951.401457956286;20026.299079532146;8263.793405164799;8468.703595374132;8516.957415212884;8530.957345213234;8756.255718263892;4339.500957389878;4663.976680116578;4691.929621055687;4736.928946065812;4810.687305325213;3474.8436320365645;3515.1212196950764;3551.2542366103407;3565.35823551758;3586.874459393961;634.6953462338012;637.9983426021103;639.8240483866881;655.446148004935;655.9770408035696;694.1150033707064;720.2545365546634;779.1546172402893;814.5886327404622;825.5170725125869;9365.344425890122;9741.805163896683;9901.603935842486;9923.900760992443;9943.602255909827;772.2239149654562;780.7072347869549;796.7729197178776;811.3771563067995;827.6358402302967;4555.567221113989;4572.565606267399;4678.60231880294;4697.647676424282;4727.669063165546;58485.41514584885;60344;62380;62727.37272627307;62734.68632656807;53256;55001.72499137479;55527;56253.156202656995;56307;49487.30895947012;49905.75047124741;50349.74825125851;50476;50504.74747626238;8601.82796344082;8643.611037503202;8689;8720.694775682821;8735.213830755263;31999.840000800777;32042.19894502656;32766.83616581902;33420.83289583537;33831.66168338285;43048.354274685276;44208.778956105016;44529.77735111433;44690.55309446864;45172.77413612911;11312.717182070513;11575.710607234887;11756.647300580997;11800.468978895799;12023.27860328383;12114.878851211375;12121.212121212093;12474.376281186085;12619.242845429304;13393.129446585941;11943.223690460092;12161.69595760113;12386.132970691964;12447.190932589352;12596.496140154291;10969.25534038743;11378.43107844588;12296.446659900505;12331;12484.750304994031;12510.812337815121;12782.36088195605;12957.416916238602;13093.279869607262;13435.529756458867;10869.67390978272;10876.347419154876;10991.340519568852;11257.268277561932;11495.195336326376;10239.692809215736;10323.317039279482;10407.531661075118;11435.085193184692;11641.59254426091 07:34:19 INFO - PROCESS | 11430 | __end_tp_report 07:34:19 INFO - PROCESS | 11430 | __start_cc_report 07:34:19 INFO - PROCESS | 11430 | _x_x_mozilla_cycle_collect,844 07:34:19 INFO - PROCESS | 11430 | __end_cc_report 07:34:19 INFO - PROCESS | 11430 | __startTimestamp1462804459868__endTimestamp 07:34:19 INFO - PROCESS | 11430 | 07:34:19 INFO - PROCESS | 11430 | ------- Summary: start ------- 07:34:19 INFO - PROCESS | 11430 | Number of tests: 6 07:34:19 INFO - PROCESS | 11430 | 07:34:19 INFO - PROCESS | 11430 | [#0] dojo.html Cycles:165 Average:5389.05 Median:5556.25 stddev:608.48 (11.0%) stddev-sans-first:584.94 07:34:19 INFO - PROCESS | 11430 | Values: 3170.9 3183.5 3193.6 3222.8 3243.7 5265.4 5371.3 5391.7 5523.3 5552.9 5381.9 5385.0 5410.2 5449.7 5480.9 4785.0 4807.5 4944.2 5018.5 5028.7 4999.7 5008.0 5062.8 5078.8 5084.7 4802.0 4841.2 4841.3 4853.7 4943.5 4842.5 4900.6 4979.3 4998.7 5024.5 4761.5 4929.9 4964.1 4967.2 5030.0 5332.1 5360.9 5424.1 5503.0 5506.4 5877.7 5897.9 5938.5 5941.8 5964.0 5684.5 5713.7 5760.8 5969.6 5975.0 5486.1 5489.3 5499.8 5507.9 5511.3 5943.3 5948.8 5958.2 5958.4 5966.4 5493.8 5690.0 5715.8 5735.6 5753.0 5862.4 5863.6 5866.2 5904.9 5919.3 5831.4 5843.4 5858.3 5859.4 5861.0 5556.2 5721.7 5728.2 5767.7 5832.2 4398.9 4411.0 4414.3 4416.8 4452.9 3805.9 3930.5 3937.8 3956.9 3959.5 5361.3 5367.2 5418.5 5439.8 5440.1 5779.8 5821.7 5827.8 5829.8 5832.1 5293.8 5399.5 5446.1 5446.9 5447.4 4982.6 5006.2 5007.6 5027.4 5036.4 5903.6 5906.4 5911.1 5932.1 5979.5 5668.4 5744.5 5781.1 5783.9 5849.5 5897.3 5897.9 5900.4 5900.7 5904.3 5703.1 5723.6 5727.7 5728.5 5731.6 5667.1 5775.2 5791.4 5807.6 5840.2 5692.1 5693.4 5703.4 5703.7 5706.6 5544.4 5635.6 5672.5 5685.5 5691.0 5489.9 5517.1 5554.6 5573.9 5589.3 5718.2 5746.1 5802.2 5813.6 5828.1 5458.9 5540.6 5637.1 5646.7 5686.3 07:34:19 INFO - PROCESS | 11430 | 07:34:19 INFO - PROCESS | 11430 | [#1] ext.html Cycles:180 Average:62778.54 Median:41470.59 stddev:137800.89 (332.3%) stddev-sans-first:138108.37 07:34:19 INFO - PROCESS | 11430 | Values: 597.5 633.6 642.3 651.9 658.7 43266.8 44775.0 44964.3 44964.6 49172.8 45947.0 46131.3 46323.5 46405.1 46502.0 8919.7 9066.9 9068.4 9076.4 9076.7 8890.7 8982.2 8987.6 8989.7 8992.1 9014.4 9026.2 9055.7 9059.2 9065.6 8919.1 8980.1 9023.5 9036.4 9043.2 8837.8 8903.8 8911.1 8912.0 8912.2 42138.6 42464.8 42515.1 42570.4 42664.4 3238.9 3407.5 3411.1 3436.5 3451.7 32053.2 32104.8 32643.2 33210.3 33237.2 4365.6 4394.6 4417.8 4445.3 4447.3 303425.0 304524.0 304736.0 306176.0 306630.0 58508.8 58699.0 58895.0 58948.4 58995.4 36794.1 38200.0 62354.0 62418.7 62474.7 16309.1 16430.8 16431.3 16453.0 16486.8 12371.0 12521.7 12530.2 12548.4 12564.1 19854.9 19934.3 20234.0 20253.1 20331.3 7168.2 7243.7 7357.3 7497.8 7586.7 1004.4 1009.5 1059.0 1138.7 1166.1 31822.5 32350.8 32617.0 32842.5 33326.0 1163.1 1216.5 1225.8 1240.9 1258.1 17278.6 17544.4 17722.6 17744.3 17793.0 480093.0 788769.0 803256.0 804147.0 804254.0 60336.0 60537.7 60838.0 60923.4 60932.7 1280.2 1384.9 1385.4 1427.6 1443.8 29159.0 32775.3 33189.8 33256.7 33790.5 50379.5 50671.2 51169.7 51173.0 51181.5 366749.0 369942.0 370208.0 370403.0 370615.0 23112.5 27727.4 28672.9 28741.7 29102.0 48238.8 48270.3 48375.8 48486.8 48572.0 40857.2 41286.8 41333.2 41789.0 42622.0 39667.4 40641.0 40771.2 41608.0 41875.0 36071.3 40647.0 41134.4 41864.6 44114.3 34649.8 36150.3 36443.3 36638.3 36985.8 27924.4 27957.3 28149.7 28203.4 28364.4 07:34:19 INFO - PROCESS | 11430 | 07:34:19 INFO - PROCESS | 11430 | [#2] jquery.html Cycles:180 Average:29867.86 Median:37338.03 stddev:87826.57 (235.2%) stddev-sans-first:88045.09 07:34:19 INFO - PROCESS | 11430 | Values: 408.5 410.4 411.5 412.1 424.7 13163.7 17786.9 18863.2 19295.7 19297.7 18141.9 18352.0 18737.2 19088.8 19094.9 5679.7 5767.3 5796.6 5806.0 5860.0 5745.8 5760.9 5776.3 5779.7 5811.6 4165.5 4351.4 4780.8 6379.9 6386.0 6179.3 6379.2 6406.5 6495.4 6506.9 5559.9 5570.2 5590.7 5612.4 5612.8 20490.7 21771.7 22556.7 23404.4 23444.0 2266.9 2306.2 2354.2 2752.8 2889.5 9167.0 9323.9 10143.7 10149.9 10223.5 1796.5 1803.8 1819.3 1866.6 1910.1 79241.2 80149.6 83139.0 84927.0 85533.0 10152.2 10308.4 10749.2 10921.9 11681.6 15239.2 15326.7 15332.3 15333.8 15508.4 7360.2 7586.6 7637.5 7720.5 7757.2 7059.6 7084.9 7195.1 7267.3 7271.7 4517.0 4662.2 4699.0 4726.5 4778.9 1875.5 1900.9 1923.9 1927.7 1950.6 948.0 987.2 1014.3 1039.3 1077.5 18499.7 18522.2 19188.1 19292.5 19367.8 927.5 974.3 987.5 992.1 1007.7 10438.5 10729.9 10805.2 10858.7 10890.1 512426.3 514966.0 526735.0 547153.0 563907.0 92068.0 93204.5 96601.0 97165.5 97600.0 1002.5 1014.9 1025.0 1031.5 1032.3 15614.6 16702.7 16831.4 16909.0 17156.2 31832.2 32996.3 36999.6 37676.4 38990.2 53819.2 53977.2 55211.0 56024.2 56151.2 8768.0 8772.4 8809.5 8885.8 9072.2 9850.8 13061.3 13306.9 13343.7 13557.7 5952.8 8152.8 11523.4 11836.9 11922.3 8659.7 11145.3 11287.4 11368.5 11559.4 12001.6 12008.4 12206.3 12305.4 12337.4 7470.5 7821.5 7881.8 8257.7 9025.7 11929.7 12286.6 12293.3 12315.9 12326.2 07:34:19 INFO - PROCESS | 11430 | 07:34:19 INFO - PROCESS | 11430 | [#3] mootools.html Cycles:180 Average:5793.27 Median:4636.54 stddev:3348.49 (72.2%) stddev-sans-first:3341.39 07:34:19 INFO - PROCESS | 11430 | Values: 1369.8 1535.9 1556.1 1773.0 1858.5 8294.6 8719.4 8720.6 8971.1 8978.6 8743.9 8904.7 8926.2 8948.9 8952.2 1940.4 1997.3 1997.6 2257.2 2283.9 2302.3 2384.6 2385.0 2393.1 2393.5 2297.3 2304.3 2324.3 2324.5 2350.2 2045.1 2114.4 2265.6 2297.6 2299.6 2057.0 2239.9 2315.6 2316.0 2324.3 8707.5 8755.6 8771.1 8774.2 8781.7 5155.4 5272.8 5277.8 5303.9 5322.5 3373.7 3405.3 3488.7 3569.9 3591.2 1194.3 1213.8 1222.2 1234.4 1258.1 12564.6 12596.9 12615.9 12619.9 12627.0 4505.5 4588.6 4632.0 4641.1 4650.4 10383.5 10388.4 10415.8 10425.9 10443.0 5244.6 5252.3 5255.7 5260.4 5265.3 4236.9 4699.1 4776.2 4805.3 4826.5 4037.9 4050.4 4100.2 4123.3 4164.0 1291.1 1315.7 1325.9 1326.0 1339.6 818.9 897.3 918.1 921.2 948.3 5400.5 5549.9 5771.2 5858.4 5922.2 968.1 979.7 985.4 1002.8 1007.8 3732.8 3760.7 3773.8 3798.4 3811.3 10298.9 10756.2 10876.3 11403.1 11446.0 10954.1 10995.5 10998.9 11147.3 11163.2 8169.3 8226.6 8347.3 8387.8 8421.1 5879.5 5905.0 5931.4 5974.7 6083.7 10164.8 10201.3 10310.1 10327.1 10402.8 10188.1 10387.3 10452.9 10552.5 10559.4 7175.6 7567.6 7739.8 7826.6 7971.0 8585.2 8591.4 8683.9 8695.4 8715.1 7349.7 7490.9 7498.7 7602.7 7781.8 7314.7 7497.7 7526.8 7655.1 7685.2 6638.2 6664.5 6702.6 6710.2 6713.7 4691.7 4737.8 4838.9 4844.1 4884.9 5071.2 5132.2 5143.2 5172.6 5215.5 07:34:19 INFO - PROCESS | 11430 | 07:34:19 INFO - PROCESS | 11430 | [#4] prototype.html Cycles:180 Average:4684.29 Median:5358.59 stddev:1374.45 (25.6%) stddev-sans-first:1338.71 07:34:19 INFO - PROCESS | 11430 | Values: 320.5 325.2 330.5 332.1 334.3 5359.5 5415.3 5416.5 5452.6 5488.0 5035.2 5079.3 5202.2 5301.2 5357.7 4132.2 4151.3 4164.9 4173.4 4178.4 4162.4 4171.7 4192.0 4204.1 4210.7 3937.1 4010.9 4099.4 4120.0 4168.9 4147.2 4163.4 4168.0 4182.6 4183.4 3677.5 3689.5 3691.5 3693.3 3713.9 5103.7 5125.3 5153.4 5156.9 5232.4 4699.5 4731.0 4735.1 4776.0 4779.2 5521.9 5524.9 5527.8 5528.4 5555.6 3914.1 3989.5 3991.1 3997.4 4029.5 5693.9 5745.5 5747.5 5752.5 5804.7 4047.6 4055.2 4066.7 4085.0 4088.4 4037.2 4129.1 4141.8 4149.6 4169.3 4700.2 4712.1 4716.0 4721.3 4734.7 5579.5 5590.9 5606.4 5625.4 5636.2 1358.4 1395.6 1399.6 1403.0 1405.4 965.8 979.6 983.3 988.0 992.3 5230.3 5264.2 5272.4 5284.6 5289.7 5565.6 5573.8 5577.3 5670.1 5679.0 5168.6 5231.8 5262.7 5289.7 5556.8 3009.2 3041.9 3045.2 3064.2 3069.6 5704.0 5717.5 5775.2 5812.2 5852.4 5375.7 5716.6 5739.3 5787.9 5803.4 5739.0 5754.1 5765.4 5810.0 5818.4 5412.6 5677.4 5715.3 5748.3 5780.6 5613.8 5615.2 5657.1 5679.9 5697.7 5783.5 5850.3 5868.7 5869.4 5871.9 3814.2 3827.2 3909.9 4057.7 4065.6 5658.7 5737.8 5816.2 5826.9 5836.4 5611.4 5651.4 5663.3 5666.3 5687.7 5348.8 5607.2 5643.4 5682.3 5705.2 5475.3 5505.7 5516.9 5517.5 5565.6 5665.6 5681.5 5689.0 5702.4 5730.8 5334.5 5582.7 5583.7 5610.0 5616.4 07:34:19 INFO - PROCESS | 11430 | 07:34:19 INFO - PROCESS | 11430 | [#5] yui.html Cycles:180 Average:14653.61 Median:24864.17 stddev:16862.00 (67.8%) stddev-sans-first:16877.05 07:34:19 INFO - PROCESS | 11430 | Values: 766.5 791.8 875.2 876.9 902.4 14166.8 14734.3 14779.4 14816.3 14842.5 13441.3 13450.9 13505.4 13527.6 13531.9 675.3 689.6 690.3 799.1 812.9 687.8 801.0 821.7 822.5 823.9 865.2 866.7 866.9 870.1 870.3 859.6 868.3 869.2 869.3 870.2 516.2 526.3 527.4 636.8 637.1 11626.4 11837.6 11863.2 11961.9 11973.0 13274.6 13887.7 14134.8 14248.6 14320.0 11252.4 11274.6 11297.3 11423.1 11703.2 3823.7 3900.6 3918.7 3992.4 4023.5 51553.0 51605.2 53950.5 54331.2 54456.7 11151.3 11259.9 11342.5 11437.8 11442.0 19600.4 19797.8 19881.1 19951.4 20026.3 8263.8 8468.7 8517.0 8531.0 8756.3 4339.5 4664.0 4691.9 4736.9 4810.7 3474.8 3515.1 3551.3 3565.4 3586.9 634.7 638.0 639.8 655.4 656.0 694.1 720.3 779.2 814.6 825.5 9365.3 9741.8 9901.6 9923.9 9943.6 772.2 780.7 796.8 811.4 827.6 4555.6 4572.6 4678.6 4697.6 4727.7 58485.4 60344.0 62380.0 62727.4 62734.7 53256.0 55001.7 55527.0 56253.2 56307.0 49487.3 49905.8 50349.7 50476.0 50504.7 8601.8 8643.6 8689.0 8720.7 8735.2 31999.8 32042.2 32766.8 33420.8 33831.7 43048.4 44208.8 44529.8 44690.6 45172.8 11312.7 11575.7 11756.6 11800.5 12023.3 12114.9 12121.2 12474.4 12619.2 13393.1 11943.2 12161.7 12386.1 12447.2 12596.5 10969.3 11378.4 12296.4 12331.0 12484.8 12510.8 12782.4 12957.4 13093.3 13435.5 10869.7 10876.3 10991.3 11257.3 11495.2 10239.7 10323.3 10407.5 11435.1 11641.6 07:34:19 INFO - PROCESS | 11430 | -------- Summary: end -------- 07:34:19 INFO - PROCESS | 11430 | 07:34:20 INFO - TEST-INFO | 11430: exit 0 07:34:20 INFO - TEST-OK | dromaeo_css | took 1115260ms 07:34:20 INFO - TEST-START | kraken 07:34:20 INFO - operating with platform_type : linux_ 07:34:20 INFO - Initialising browser for kraken test... 07:34:20 INFO - TEST-INFO | started process 11618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJqlfzW/profile http://localhost:44218/getInfo.html) 07:34:25 INFO - PROCESS | 11618 | __metrics Screen width/height:1600/1200 07:34:25 INFO - PROCESS | 11618 | colorDepth:24 07:34:25 INFO - PROCESS | 11618 | Browser inner width/height: 1024/697 07:34:25 INFO - PROCESS | 11618 | __metrics 07:34:26 ERROR - PROCESS | 11618 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:34:27 INFO - TEST-INFO | 11618: exit 0 07:34:27 INFO - Browser initialized. 07:34:27 INFO - Running cycle 1/1 for kraken test... 07:34:27 INFO - TEST-INFO | started process 11698 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJqlfzW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:39 INFO - PROCESS | 11698 | RSS: Main: 152637440 07:34:39 INFO - PROCESS | 11698 | 07:34:41 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44218/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:42 INFO - PROCESS | 11698 | RSS: Main: 208449536 07:34:42 INFO - PROCESS | 11698 | 07:34:45 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44218/tests/kraken/driver.html?testName=audio-dft) 07:34:46 INFO - PROCESS | 11698 | RSS: Main: 197021696 07:34:46 INFO - PROCESS | 11698 | 07:34:49 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44218/tests/kraken/driver.html?testName=audio-fft) 07:34:50 INFO - PROCESS | 11698 | RSS: Main: 264818688 07:34:50 INFO - PROCESS | 11698 | 07:34:52 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44218/tests/kraken/driver.html?testName=audio-oscillator) 07:34:52 INFO - PROCESS | 11698 | RSS: Main: 174571520 07:34:52 INFO - PROCESS | 11698 | 07:34:55 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:55 INFO - PROCESS | 11698 | RSS: Main: 178360320 07:34:55 INFO - PROCESS | 11698 | 07:34:58 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44218/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:59 INFO - PROCESS | 11698 | RSS: Main: 214724608 07:34:59 INFO - PROCESS | 11698 | 07:35:02 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44218/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:03 INFO - PROCESS | 11698 | RSS: Main: 212971520 07:35:03 INFO - PROCESS | 11698 | 07:35:06 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44218/tests/kraken/driver.html?testName=json-parse-financial) 07:35:07 INFO - PROCESS | 11698 | RSS: Main: 213213184 07:35:07 INFO - PROCESS | 11698 | 07:35:08 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:09 INFO - PROCESS | 11698 | RSS: Main: 203083776 07:35:09 INFO - PROCESS | 11698 | 07:35:11 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44218/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:11 INFO - PROCESS | 11698 | RSS: Main: 206950400 07:35:11 INFO - PROCESS | 11698 | 07:35:13 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:14 INFO - PROCESS | 11698 | RSS: Main: 215007232 07:35:14 INFO - PROCESS | 11698 | 07:35:17 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:17 INFO - PROCESS | 11698 | RSS: Main: 222621696 07:35:17 INFO - PROCESS | 11698 | 07:35:20 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:21 INFO - PROCESS | 11698 | RSS: Main: 218320896 07:35:21 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | Cycle 1(1): loaded http://localhost:44218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44218/tests/kraken/driver.html?testName=ai-astar) 07:35:23 INFO - PROCESS | 11698 | RSS: Main: 264114176 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | __start_tp_report 07:35:23 INFO - PROCESS | 11698 | _x_x_mozilla_page_load 07:35:23 INFO - PROCESS | 11698 | _x_x_mozilla_page_load_details 07:35:23 INFO - PROCESS | 11698 | |i|pagename|runs| 07:35:23 INFO - PROCESS | 11698 | |0;ai-astar;112;105;111;112;110;111;110;112;110;111 07:35:23 INFO - PROCESS | 11698 | |1;audio-beat-detection;155;134;158;211;127;153;150;140;185;125 07:35:23 INFO - PROCESS | 11698 | |2;audio-dft;162;161;161;160;161;161;162;162;162;160 07:35:23 INFO - PROCESS | 11698 | |3;audio-fft;74;75;76;151;77;76;76;76;142;75 07:35:23 INFO - PROCESS | 11698 | |4;audio-oscillator;92;94;146;91;91;91;132;93;92;125 07:35:23 INFO - PROCESS | 11698 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;116 07:35:23 INFO - PROCESS | 11698 | |6;imaging-darkroom;145;145;146;146;146;145;145;145;145;148 07:35:23 INFO - PROCESS | 11698 | |7;imaging-desaturate;95;96;95;96;96;95;95;96;95;95 07:35:23 INFO - PROCESS | 11698 | |8;json-parse-financial;56;54;57;55;55;56;56;110;54;53 07:35:23 INFO - PROCESS | 11698 | |9;json-stringify-tinderbox;59;60;60;59;59;59;59;59;60;59 07:35:23 INFO - PROCESS | 11698 | |10;stanford-crypto-aes;79;78;78;79;85;83;81;80;87;86 07:35:23 INFO - PROCESS | 11698 | |11;stanford-crypto-ccm;132;125;132;121;124;130;122;131;189;133 07:35:23 INFO - PROCESS | 11698 | |12;stanford-crypto-pbkdf2;171;176;168;171;174;166;166;168;167;167 07:35:23 INFO - PROCESS | 11698 | |13;stanford-crypto-sha256-iterative;64;69;73;67;63;62;63;63;63;62 07:35:23 INFO - PROCESS | 11698 | __end_tp_report 07:35:23 INFO - PROCESS | 11698 | __start_cc_report 07:35:23 INFO - PROCESS | 11698 | _x_x_mozilla_cycle_collect,1825 07:35:23 INFO - PROCESS | 11698 | __end_cc_report 07:35:23 INFO - PROCESS | 11698 | __startTimestamp1462804523320__endTimestamp 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | ------- Summary: start ------- 07:35:23 INFO - PROCESS | 11698 | Number of tests: 14 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.07 (1.9%) stddev-sans-first:2.11 07:35:23 INFO - PROCESS | 11698 | Values: 112.0 105.0 111.0 112.0 110.0 111.0 110.0 112.0 110.0 111.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:154.00 stddev:26.69 (17.3%) stddev-sans-first:28.30 07:35:23 INFO - PROCESS | 11698 | Values: 155.0 134.0 158.0 211.0 127.0 153.0 150.0 140.0 185.0 125.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 07:35:23 INFO - PROCESS | 11698 | Values: 162.0 161.0 161.0 160.0 161.0 161.0 162.0 162.0 162.0 160.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#3] audio-fft Cycles:10 Average:89.80 Median:76.00 stddev:29.97 (39.4%) stddev-sans-first:31.24 07:35:23 INFO - PROCESS | 11698 | Values: 74.0 75.0 76.0 151.0 77.0 76.0 76.0 76.0 142.0 75.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#4] audio-oscillator Cycles:10 Average:104.70 Median:91.50 stddev:21.08 (23.0%) stddev-sans-first:21.85 07:35:23 INFO - PROCESS | 11698 | Values: 92.0 94.0 146.0 91.0 91.0 91.0 132.0 93.0 92.0 125.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 07:35:23 INFO - PROCESS | 11698 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:145.50 stddev:0.97 (0.7%) stddev-sans-first:1.00 07:35:23 INFO - PROCESS | 11698 | Values: 145.0 145.0 146.0 146.0 146.0 145.0 145.0 145.0 145.0 148.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:35:23 INFO - PROCESS | 11698 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:55.50 stddev:17.40 (31.3%) stddev-sans-first:18.37 07:35:23 INFO - PROCESS | 11698 | Values: 56.0 54.0 57.0 55.0 55.0 56.0 56.0 110.0 54.0 53.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:35:23 INFO - PROCESS | 11698 | Values: 59.0 60.0 60.0 59.0 59.0 59.0 59.0 59.0 60.0 59.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:3.41 (4.2%) stddev-sans-first:3.48 07:35:23 INFO - PROCESS | 11698 | Values: 79.0 78.0 78.0 79.0 85.0 83.0 81.0 80.0 87.0 86.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:131.50 stddev:19.87 (15.1%) stddev-sans-first:21.06 07:35:23 INFO - PROCESS | 11698 | Values: 132.0 125.0 132.0 121.0 124.0 130.0 122.0 131.0 189.0 133.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:169.50 stddev:3.47 (2.0%) stddev-sans-first:3.63 07:35:23 INFO - PROCESS | 11698 | Values: 171.0 176.0 168.0 171.0 174.0 166.0 166.0 168.0 167.0 167.0 07:35:23 INFO - PROCESS | 11698 | 07:35:23 INFO - PROCESS | 11698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:63.50 stddev:3.63 (5.7%) stddev-sans-first:3.84 07:35:23 INFO - PROCESS | 11698 | Values: 64.0 69.0 73.0 67.0 63.0 62.0 63.0 63.0 63.0 62.0 07:35:23 INFO - PROCESS | 11698 | -------- Summary: end -------- 07:35:23 INFO - PROCESS | 11698 | 07:35:24 INFO - TEST-INFO | 11698: exit 0 07:35:24 INFO - TEST-OK | kraken | took 63728ms 07:35:24 INFO - SUITE-END | took 1178s 07:35:24 INFO - Completed test suite (00:19:39) 07:35:24 INFO - javascript benchmark 07:35:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3170.9048728538137, 3183.538386933895, 3193.6007999000117, 3222.7744057915957, 3243.6756324367566, 5265.420803711599, 5371.274877891484, 5391.676499410039, 5523.281973343464, 5552.944470555293, 5381.892362152755, 5385.0, 5410.242566040757, 5449.6730196188255, 5480.9177862332, 4785.0, 4807.543283388072, 4944.233643785219, 5018.473060328668, 5028.723420211887, 4999.700017998914, 5008.048470790556, 5062.772175252123, 5078.847634570969, 5084.745762711868, 4802.03959208158, 4841.225403935354, 4841.3222148899185, 4853.660243782937, 4943.505649435064, 4842.467328593852, 4900.607951363918, 4979.278004689336, 4998.650094493387, 5024.497550244946, 4761.500042495557, 4929.926051109236, 4964.106460837048, 4967.230079337708, 5030.0, 5332.120200167006, 5360.91958620621, 5424.105022671254, 5502.972485137549, 5506.366767821672, 5877.735501902382, 5897.911531327033, 5938.465538101592, 5941.762329506858, 5964.0457526795935, 5684.516816070639, 5713.74288157034, 5760.8271751847515, 5969.611975221596, 5975.0, 5486.1222204447095, 5489.34127904654, 5499.835004949858, 5507.9449205507835, 5511.338639363262, 5943.31651860033, 5948.762049518057, 5958.165856779968, 5958.404159584094, 5966.433188847052, 5493.752781124859, 5690.0, 5715.799947001835, 5735.627184233012, 5752.9712351437975, 5862.355140934494, 5863.648181109147, 5866.208061911672, 5904.852378690567, 5919.289685237799, 5831.3877042910735, 5843.444872737083, 5858.297004359419, 5859.44335288147, 5860.970695146582, 5556.249906262684, 5721.713914304268, 5728.169415434739, 5767.653940763484, 5832.1834943108, 4398.912021759611, 4411.0, 4414.3157810539415, 4416.823327066882, 4452.910941781146, 3805.9429108563395, 3930.5283365996265, 3937.822797974098, 3956.9010774730864, 3959.4852669152824, 5361.329833770778, 5367.221752845816, 5418.512333889968, 5439.755211015514, 5440.102383106822, 5779.797707080232, 5821.679807610622, 5827.7668893244645, 5829.795957141479, 5832.066869300891, 5293.788248470018, 5399.541039011649, 5446.128619420953, 5446.91829622556, 5447.428020057916, 4982.60139188864, 5006.224035274466, 5007.6494645375205, 5027.421846487628, 5036.370453693288, 5903.557233207526, 5906.40935906406, 5911.083782013795, 5932.139839723302, 5979.491743201789, 5668.37647858727, 5744.4829965303325, 5781.075027995669, 5783.884322313615, 5849.502792262535, 5897.292324921037, 5897.941020589739, 5900.380460051632, 5900.675462849585, 5904.291485021825, 5703.144528320785, 5723.5707321950185, 5727.6849773262875, 5728.484436400578, 5731.627444216113, 5667.149927510742, 5775.249217601853, 5791.362950075572, 5807.622504537191, 5840.153177789111, 5692.1461780733225, 5693.430656934273, 5703.4296570344295, 5703.686297253525, 5706.6005379624685, 5544.445555444423, 5635.605507614428, 5672.546196304368, 5685.545156387562, 5691.0, 5489.945100548944, 5517.144842549411, 5554.583406244628, 5573.888522229614, 5589.329280486368, 5718.228039214653, 5746.080627099644, 5802.216700745345, 5813.563982701399, 5828.125781132864, 5458.8908221834545, 5540.584456165723, 5637.098064309691, 5646.661200327993, 5686.289213848269], "value": 5348.563449989897, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.5458651424916, 633.6071635585936, 642.3127253838395, 651.9445847102996, 658.7068754404291, 43266.78366608167, 44775.0, 44964.32553511692, 44964.550354496445, 49172.754136229356, 45947.0, 46131.308030379485, 46323.53676463234, 46405.07189856201, 46502.0, 8919.687810926602, 9066.909330906705, 9068.410553314046, 9076.41003334781, 9076.682316118937, 8890.73327800167, 8982.236509896667, 8987.595558199897, 8989.685361012365, 8992.100789920989, 9014.36899417041, 9026.187643112118, 9055.683051093212, 9059.229965452945, 9065.59204835784, 8919.063498332678, 8980.146886045848, 9023.458592484472, 9036.412633178856, 9043.231325337289, 8837.779055523599, 8903.821923561558, 8911.064338244521, 8912.0, 8912.24245939096, 42138.57861421377, 42464.78767606142, 42515.14969700589, 42570.36144457835, 42664.36003459951, 3238.87044518219, 3407.505911642823, 3411.1131105912395, 3436.4845273209216, 3451.6548345165534, 32053.1986700332, 32104.83947580247, 32643.18392040194, 33210.33579328424, 33237.16907077318, 4365.607095361433, 4394.648428125743, 4417.823287068513, 4445.288753799409, 4447.310666846644, 303425.0, 304524.0, 304736.0, 306176.0, 306630.0, 58508.82982340329, 58699.0, 58895.0, 58948.41051589515, 58995.41004589899, 36794.08014799598, 38200.0, 62354.0, 62418.687906561085, 62474.68762656249, 16309.102999335151, 16430.75353869669, 16431.342746290014, 16453.0, 16486.83513164877, 12371.0, 12521.686957825945, 12530.185537940004, 12548.372581371077, 12564.120511564102, 19854.90072549628, 19934.30229941945, 20234.0, 20253.08861101254, 20331.255280537232, 7168.247334029956, 7243.7464688735645, 7357.264273572707, 7497.812554686177, 7586.696532138763, 1004.3923426327113, 1009.5255230041869, 1059.0098258128521, 1138.6754774889116, 1166.055495049013, 31822.522662160085, 32350.83824580862, 32617.0, 32842.50736238958, 33326.0, 1163.139276935062, 1216.4586758892208, 1225.7732319520917, 1240.8883200511998, 1258.0690289185936, 17278.568035799206, 17544.385946491813, 17722.5569360767, 17744.33092449539, 17793.0, 480093.0, 788769.0, 803256.0, 804147.0, 804254.0, 60336.0, 60537.69731151404, 60838.0, 60923.390766092656, 60932.69533652392, 1280.21266920843, 1384.9307534623229, 1385.3835043405588, 1427.5931359562476, 1443.8483959184134, 29159.0, 32775.34449310953, 33189.83405082959, 33256.66743332632, 33790.49314260239, 50379.496205038944, 50671.2399314018, 51169.744151279, 51173.0, 51181.48818511916, 366749.0, 369942.0, 370208.0, 370403.0, 370615.0, 23112.537749244584, 27727.44545109127, 28672.85663571669, 28741.712582873904, 29102.0, 48238.75880620575, 48270.275945860136, 48375.75812121058, 48486.75756621194, 48572.0, 40857.1828563433, 41286.79356603198, 41333.1733365325, 41789.0, 42622.0, 39667.40498892461, 40641.0, 40771.1845763089, 41608.0, 41875.0, 36071.27857442889, 40647.0, 41134.382984255855, 41864.58135418607, 44114.33828492511, 34649.82675086609, 36150.27699446049, 36443.27113457769, 36638.267234655694, 36985.81507092447, 27924.441511169258, 27957.301067473476, 28149.71850281471, 28203.43593128085, 28364.432711345245], "value": 20336.357770952614, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.47103001612913, 410.4336016297511, 411.5493534579635, 412.13040484577516, 424.71968500789484, 13163.670908227276, 17786.91106544467, 18863.245470181177, 19295.710564341545, 19297.71053434198, 18141.90929045353, 18351.98128205896, 18737.15682794274, 19088.80911190888, 19094.904525477352, 5679.659220446766, 5767.33675627304, 5796.565257605696, 5805.970970145165, 5859.970700146493, 5745.770169193227, 5760.942390576082, 5776.277965254343, 5779.682117483537, 5811.593188476808, 4165.458490396244, 4351.434313539251, 4780.784864681098, 6379.936200638004, 6386.042093685938, 6179.289381721114, 6379.23449186096, 6406.487481001532, 6495.382938620847, 6506.869862602769, 5559.9444005559835, 5570.192322113271, 5590.748416321276, 5612.410696876851, 5612.7754889804355, 20490.692639610417, 21771.67342489864, 22556.66165007526, 23404.414889627726, 23444.0, 2266.92065777697, 2306.1928325086255, 2354.1878052072007, 2752.8348299101917, 2889.537673972154, 9167.0, 9323.860142097874, 10143.746406339827, 10149.949250253701, 10223.539940702687, 1796.5329014456336, 1803.7835459744915, 1819.2813838533837, 1866.56135808085, 1910.0640686063869, 79241.20758792396, 80149.59925200394, 83139.0, 84927.0, 85533.0, 10152.238582106223, 10308.433036183082, 10749.193810464247, 10921.890781092246, 11681.649550513499, 15239.161846098572, 15326.693466130615, 15332.31004604773, 15333.846661533466, 15508.379664813507, 7360.227176146427, 7586.62066896664, 7637.541747495168, 7720.498167619086, 7757.224277572198, 7059.6117213552725, 7084.92915070853, 7195.13658361, 7267.273272672796, 7271.67277472515, 4517.0, 4662.207424737802, 4698.95301046992, 4726.480087190406, 4778.904421911612, 1875.5217419557925, 1900.942971710851, 1923.9422817315503, 1927.681932481125, 1950.5611237471455, 947.9573419196153, 987.195435719886, 1014.2595904989251, 1039.2777019971047, 1077.5474300793528, 18499.722504162448, 18522.166502507418, 19188.13653385601, 19292.517687057934, 19367.80632193688, 927.4945154890601, 974.2644303550916, 987.4914419074182, 992.1467537917385, 1007.6926537406162, 10438.478076096164, 10729.9463502682, 10805.189610779065, 10858.72853178661, 10890.074343680717, 512426.25442473573, 514966.0, 526735.0, 547153.0, 563907.0, 92068.0, 93204.53397733104, 96601.0, 97165.5141724301, 97600.0, 1002.4787110702393, 1014.91373233276, 1024.9641262555924, 1031.4945676618404, 1032.318669678009, 15614.609634758768, 16702.66594668124, 16831.41090061842, 16909.0, 17156.227969741143, 31832.204194895312, 32996.34007319792, 36999.630003700695, 37676.43485347777, 38990.220195595364, 53819.19271211013, 53977.19034214569, 55211.0, 56024.15963760465, 56151.157732633226, 8767.956160219159, 8772.429792063496, 8809.515476648847, 8885.777855553662, 9072.183503484717, 9850.753731156778, 13061.281629510468, 13306.86693133095, 13343.66640833948, 13557.728845422838, 5952.76188952437, 8152.796180095545, 11523.423828808358, 11836.881631183922, 11922.284662920252, 8659.740207793777, 11145.331280123219, 11287.379194144072, 11368.54525818958, 11559.422028898689, 12001.63995080149, 12008.39958002114, 12206.267623942593, 12305.446254918372, 12337.383130843602, 7470.4770666052855, 7821.491603046012, 7881.763547093597, 8257.669693212205, 9025.729228123168, 11929.656609775524, 12286.569970051005, 12293.323867187391, 12315.93842030784, 12326.198797078161], "value": 9058.588405544484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.8082268482408, 1535.9078455292683, 1556.0974634711865, 1772.9556761080971, 1858.5446565591433, 8294.62674179662, 8719.389642725011, 8720.60757265923, 8971.102889711026, 8978.563429851225, 8743.86884196736, 8904.73285801427, 8926.196642302191, 8948.91051089489, 8952.239059679934, 1940.4372731907729, 1997.340877510418, 1997.6304383688991, 2257.1761307122906, 2283.908643654252, 2302.343832007878, 2384.558856611524, 2384.9761502384927, 2393.1384701507445, 2393.4614711689906, 2297.253392647388, 2304.2626359564947, 2324.337563794319, 2324.5467133908896, 2350.236173243694, 2045.089934978935, 2114.4291041418883, 2265.63749800032, 2297.574948634508, 2299.574578702937, 2056.979430205694, 2239.9328020159423, 2315.583195024895, 2315.988420057906, 2324.3143272734414, 8707.521086340248, 8755.56222188888, 8771.12288771124, 8774.166454186841, 8781.692640757543, 5155.381354237478, 5272.841814745564, 5277.8416647500635, 5303.893922121536, 5322.494363035506, 3373.662633736631, 3405.250844814137, 3488.651134886491, 3569.8929032129076, 3591.2458383739445, 1194.3013337197663, 1213.83006379107, 1222.1506053292965, 1234.4259919137644, 1258.0753146437453, 12564.623061308175, 12596.874031259662, 12615.873841261653, 12619.936900315532, 12627.0, 4505.504394516601, 4588.632909367243, 4631.95368046322, 4641.118187544355, 4650.441946966318, 10383.480825958823, 10388.37669739818, 10415.791684166274, 10425.9478702606, 10443.0, 5244.632875698664, 5252.29094072303, 5255.710935898486, 5260.447652996457, 5265.341832270966, 4236.872893813191, 4699.060187962421, 4776.2119250324, 4805.303231031481, 4826.469088400273, 4037.858674946363, 4050.4126901599693, 4100.2414553307735, 4123.299039163349, 4163.958360416417, 1291.1026836348647, 1315.7434300311538, 1325.8872995795466, 1326.0452474218548, 1339.6382976596265, 818.9099199088096, 897.3314880414133, 918.1231923513029, 921.1617428140494, 948.2603569216022, 5400.540954018952, 5549.861253468614, 5771.163181338682, 5858.384869588717, 5922.170896074467, 968.1480297338438, 979.7109852593502, 985.4333758089127, 1002.8417178159237, 1007.8337074382645, 3732.757370770891, 3760.6615404613717, 3773.7924414156937, 3798.3542797724454, 3811.2568049230135, 10298.948505257576, 10756.19328550362, 10876.347419154876, 11403.144764142722, 11445.969862712229, 10954.068904143238, 10995.450227488594, 10998.890011099948, 11147.331160130418, 11163.162762792661, 8169.305609023299, 8226.588670566447, 8347.332213423033, 8387.832243355098, 8421.115782842835, 5879.529637628894, 5904.970475147768, 5931.377205393372, 5974.731137098928, 6083.6653984029535, 10164.847527287244, 10201.285909986229, 10310.07209351162, 10327.070563649308, 10402.791944161227, 10188.134008609351, 10387.324823886423, 10452.895471045193, 10552.472376381304, 10559.366438013743, 7175.605341706257, 7567.621618919142, 7739.845203095794, 7826.608669566613, 7970.960145199237, 8585.227329540372, 8591.355648326275, 8683.913160868311, 8695.434796738191, 8715.128487151234, 7349.706011759684, 7490.887636685563, 7498.662560184695, 7602.695892164473, 7781.805454863674, 7314.743983960536, 7497.662605182671, 7526.849463010819, 7655.119661238806, 7685.23147685227, 6638.17022872141, 6664.5334826561675, 6702.631355275506, 6710.194776626836, 6713.697883595152, 4691.741954192552, 4737.763111844325, 4838.8790280241865, 4844.128056949783, 4884.90230195387, 5071.2139618359215, 5132.153194722829, 5143.202803565453, 5172.637915345889, 5215.478452154906], "value": 4623.96429285967, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.50642011302597, 325.18216685037135, 330.5273458953696, 332.0685477236353, 334.25627977749525, 5359.499340184745, 5415.346480224691, 5416.539594134503, 5452.563794896414, 5488.0, 5035.194368900977, 5079.339685840845, 5202.167653175493, 5301.1783173608055, 5357.678539287645, 4132.173565286939, 4151.252774500589, 4164.854230101947, 4173.394857745625, 4178.3732440134, 4162.354835000565, 4171.749695018293, 4191.979040104795, 4204.117135401554, 4210.663146948237, 3937.1290939338983, 4010.939835902464, 4099.364598487239, 4119.979400102995, 4168.895777605554, 4147.232761939051, 4163.354680024601, 4167.958320416802, 4182.602652747984, 4183.393407955829, 3677.5035370225214, 3689.538807649044, 3691.464737613058, 3693.279810436966, 3713.9442908356395, 5103.744812759347, 5125.3080834087295, 5153.3558305211845, 5156.92264616031, 5232.372115346145, 4699.506551812079, 4730.976345118287, 4735.100330937145, 4776.0, 4779.163646361872, 5521.895620875801, 5524.889502209973, 5527.751251193706, 5528.391876893538, 5555.611107222496, 3914.080191155076, 3989.4813674222455, 3991.1419044905483, 3997.4403583498333, 4029.5164580250266, 5693.946619875336, 5745.482906538432, 5747.5114615257335, 5752.453516915886, 5804.65172089676, 4047.5952404759287, 4055.2092341993616, 4066.674666026711, 4084.9591504085174, 4088.448059511987, 4037.152198038386, 4129.112240868228, 4141.7722025288895, 4149.585041495826, 4169.3120635094865, 4700.177468942989, 4712.128256272601, 4715.976420117878, 4721.268203428474, 4734.715917044989, 5579.46995035471, 5590.903411220792, 5606.439356064442, 5625.4374562544235, 5636.210930469738, 1358.381936219018, 1395.5952773695717, 1399.6181960256906, 1402.9929850350684, 1405.374608299297, 965.8116667249959, 979.6424305128577, 983.3018556824592, 987.9604815807431, 992.3103443106971, 5230.320058392384, 5264.236685680555, 5272.420033796279, 5284.603654725911, 5289.68261904287, 5565.638233514808, 5573.804916827891, 5577.27495425592, 5670.121131224667, 5678.97160514203, 5168.58651307902, 5231.764570594332, 5262.657927234717, 5289.656172348785, 5556.77772889088, 3009.2476880779805, 3041.8935337263088, 3045.1778019934936, 3064.233941514621, 3069.6493542841527, 5704.0, 5717.456841600041, 5775.249217601685, 5812.215350927655, 5852.356240813507, 5375.6774593524515, 5716.628009277827, 5739.278216535023, 5787.913181302284, 5803.448672376117, 5738.971305143531, 5754.136879468113, 5765.394633563499, 5810.012297909366, 5818.418158184232, 5412.594055445936, 5677.3754886963225, 5715.31416230055, 5748.281464816898, 5780.5953583248765, 5613.803516876889, 5615.18579805934, 5657.10486986864, 5679.914801278067, 5697.7151142443545, 5783.479486846204, 5850.297964244318, 5868.67722275279, 5869.383714709894, 5871.941280587311, 3814.218085292564, 3827.2345530893376, 3909.863154789569, 4057.695672824491, 4065.593440655911, 5658.7082231694585, 5737.770489180386, 5816.156657284585, 5826.941730582809, 5836.4028007536235, 5611.38274789781, 5651.4348565143155, 5663.292088488939, 5666.34836993751, 5687.687177205294, 5348.839534813962, 5607.158926161109, 5643.407442218508, 5682.289713785777, 5705.22979397776, 5475.260839786578, 5505.697186654773, 5516.889662206813, 5517.503424691637, 5565.55475561946, 5665.575081868794, 5681.466004178931, 5688.971555142198, 5702.37273899879, 5730.770769169187, 5334.493223143951, 5582.692951887523, 5583.682771649882, 5609.9804070533755, 5616.354119276336], "value": 4246.068018572577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.4902839611657, 791.7624712586224, 875.216681070442, 876.9035406105331, 902.4089221559881, 14166.787498187523, 14734.336954837032, 14779.408823647042, 14816.333265003073, 14842.480513182041, 13441.32793360333, 13450.865491345083, 13505.392257348418, 13527.594172174826, 13531.864681353183, 675.2740803636086, 689.6034780001519, 690.3165865792879, 799.0690845165375, 812.9187081291853, 687.7764726463894, 800.9839803203932, 821.6713314674148, 822.4900561651784, 823.9093699693029, 865.1521508921229, 866.7096522664915, 866.9479831210116, 870.0690261420283, 870.3124531620012, 859.6260626627405, 868.2923417414787, 869.2003356911656, 869.326272139094, 870.1820288928387, 516.2076213013045, 526.3026489900897, 527.4172039895936, 636.7771280051991, 637.0794202377566, 11626.418679066013, 11837.585684501088, 11863.169578129535, 11961.94019029908, 11973.0, 13274.601761947157, 13887.652808679763, 14134.787978180335, 14248.643783905381, 14320.0, 11252.43737813106, 11274.605388811435, 11297.26567773092, 11423.086153107732, 11703.23928944616, 3823.655870971626, 3900.5514365848007, 3918.7060970427046, 3992.3612222044335, 4023.4568333274924, 51553.0, 51605.22592161121, 53950.46049539494, 54331.18503222415, 54456.727716361165, 11151.275167114112, 11259.887401126047, 11342.489587968561, 11437.771244575228, 11442.0, 19600.411987640393, 19797.802021979885, 19881.105350259273, 19951.401457956286, 20026.299079532146, 8263.793405164799, 8468.703595374132, 8516.957415212884, 8530.957345213234, 8756.255718263892, 4339.500957389878, 4663.976680116578, 4691.929621055687, 4736.928946065812, 4810.687305325213, 3474.8436320365645, 3515.1212196950764, 3551.2542366103407, 3565.35823551758, 3586.874459393961, 634.6953462338012, 637.9983426021103, 639.8240483866881, 655.446148004935, 655.9770408035696, 694.1150033707064, 720.2545365546634, 779.1546172402893, 814.5886327404622, 825.5170725125869, 9365.344425890122, 9741.805163896683, 9901.603935842486, 9923.900760992443, 9943.602255909827, 772.2239149654562, 780.7072347869549, 796.7729197178776, 811.3771563067995, 827.6358402302967, 4555.567221113989, 4572.565606267399, 4678.60231880294, 4697.647676424282, 4727.669063165546, 58485.41514584885, 60344.0, 62380.0, 62727.37272627307, 62734.68632656807, 53256.0, 55001.72499137479, 55527.0, 56253.156202656995, 56307.0, 49487.30895947012, 49905.75047124741, 50349.74825125851, 50476.0, 50504.74747626238, 8601.82796344082, 8643.611037503202, 8689.0, 8720.694775682821, 8735.213830755263, 31999.840000800777, 32042.19894502656, 32766.83616581902, 33420.83289583537, 33831.66168338285, 43048.354274685276, 44208.778956105016, 44529.77735111433, 44690.55309446864, 45172.77413612911, 11312.717182070513, 11575.710607234887, 11756.647300580997, 11800.468978895799, 12023.27860328383, 12114.878851211375, 12121.212121212093, 12474.376281186085, 12619.242845429304, 13393.129446585941, 11943.223690460092, 12161.69595760113, 12386.132970691964, 12447.190932589352, 12596.496140154291, 10969.25534038743, 11378.43107844588, 12296.446659900505, 12331.0, 12484.750304994031, 12510.812337815121, 12782.36088195605, 12957.416916238602, 13093.279869607262, 13435.529756458867, 10869.67390978272, 10876.347419154876, 10991.340519568852, 11257.268277561932, 11495.195336326376, 10239.692809215736, 10323.317039279482, 10407.531661075118, 11435.085193184692, 11641.59254426091], "value": 6736.29896338091, "unit": "score"}], "name": "dromaeo_css", "value": 7120.434100347864, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 112.0, 110.0, 111.0, 110.0, 112.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 134.0, 158.0, 211.0, 127.0, 153.0, 150.0, 140.0, 185.0, 125.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 162.0, 162.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 151.0, 77.0, 76.0, 76.0, 76.0, 142.0, 75.0], "value": 89.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 146.0, 91.0, 91.0, 91.0, 132.0, 93.0, 92.0, 125.0], "value": 104.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 148.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 57.0, 55.0, 55.0, 56.0, 56.0, 110.0, 54.0, 53.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 79.0, 85.0, 83.0, 81.0, 80.0, 87.0, 86.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 132.0, 121.0, 124.0, 130.0, 122.0, 131.0, 189.0, 133.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 168.0, 171.0, 174.0, 166.0, 166.0, 168.0, 167.0, 167.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 73.0, 67.0, 63.0, 62.0, 63.0, 63.0, 63.0, 62.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1547.3000000000002, "alertThreshold": 2.0}]} 07:35:24 INFO - Return code: 0 07:35:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:35:24 ERROR - # TBPL SUCCESS # 07:35:24 INFO - Running post-action listener: _resource_record_post_action 07:35:24 INFO - ##### 07:35:24 INFO - ##### Finished run-tests step (success) 07:35:24 INFO - ##### 07:35:24 INFO - Running post-run listener: _resource_record_post_run 07:35:25 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535519232; Read time: 20; Write time: 1037800 07:35:25 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 0; Write bytes: 244891648; Read time: 0; Write time: 606180 07:35:25 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290627584; Read time: 20; Write time: 431620 07:35:25 INFO - Running post-run listener: _upload_blobber_files 07:35:25 INFO - Blob upload gear active. 07:35:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35:25 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 07:35:25 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:35:25 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:35:26 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:35:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:35:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:26 INFO - (blobuploader) - INFO - Done attempting. 07:35:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:35:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:35:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:27 INFO - (blobuploader) - INFO - Done attempting. 07:35:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:27 INFO - Return code: 0 07:35:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f64cf62cdcdbc518ad3bc041a3c85bcc9b68e3139c17a11503529a9f442684ab1ebd0b49a1f2928fd4c4ae8cde2a2b51d387b7e6c656fb2de03d1b42b246b6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1973960d720b4a9164ea6a9e02dfaed2f8167dd0f98e4ca1f0e05ab15e41ad877a5460ad10a9f8dd4722a7f556df04cbd95346654e7e541c5c3484fb11eb4756"} 07:35:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:27 INFO - Contents: 07:35:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f64cf62cdcdbc518ad3bc041a3c85bcc9b68e3139c17a11503529a9f442684ab1ebd0b49a1f2928fd4c4ae8cde2a2b51d387b7e6c656fb2de03d1b42b246b6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1973960d720b4a9164ea6a9e02dfaed2f8167dd0f98e4ca1f0e05ab15e41ad877a5460ad10a9f8dd4722a7f556df04cbd95346654e7e541c5c3484fb11eb4756"} 07:35:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:27 INFO - Copying logs to upload dir... 07:35:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.236679 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-09 07:35:27.570922) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:35:27.576994) ========= 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=745a4373a2a16df560f216e000000264-1462803224.304042-1463327556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f64cf62cdcdbc518ad3bc041a3c85bcc9b68e3139c17a11503529a9f442684ab1ebd0b49a1f2928fd4c4ae8cde2a2b51d387b7e6c656fb2de03d1b42b246b6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1973960d720b4a9164ea6a9e02dfaed2f8167dd0f98e4ca1f0e05ab15e41ad877a5460ad10a9f8dd4722a7f556df04cbd95346654e7e541c5c3484fb11eb4756"} build_url:https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/Gx7NyQHERGCqQDddiVh7kg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f64cf62cdcdbc518ad3bc041a3c85bcc9b68e3139c17a11503529a9f442684ab1ebd0b49a1f2928fd4c4ae8cde2a2b51d387b7e6c656fb2de03d1b42b246b6b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1973960d720b4a9164ea6a9e02dfaed2f8167dd0f98e4ca1f0e05ab15e41ad877a5460ad10a9f8dd4722a7f556df04cbd95346654e7e541c5c3484fb11eb4756"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 07:35:27.605959) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:35:27.606720) ========= 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=745a4373a2a16df560f216e000000264-1462803224.304042-1463327556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 07:35:27.690293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:35:27.691001) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 07:35:27.691664) ========= ========= Total master_lag: 0.18 =========