builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1461587041.88 results: success (0) buildid: 20160422035423 builduid: e1d26a5cd477466bafcab7d720b7b498 revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:01.879046) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:01.879474) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:01.879756) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:01.895663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:01.896013) ========= 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=82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-25 05:24:04-- 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% 46.6M=0s 2016-04-25 05:24:04 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076215 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:01.985796) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:01.986377) ========= 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=82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019121 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:02.036725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:24:02.037067) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --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=82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-25 05:24:04,919 truncating revision to first 12 chars 2016-04-25 05:24:04,919 Setting DEBUG logging. 2016-04-25 05:24:04,919 attempt 1/10 2016-04-25 05:24:04,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0361b7030d36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 05:24:05,613 unpacking tar archive at: fx-team-0361b7030d36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.990214 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:24:03.039910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:03.040221) ========= script_repo_revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:03.040607) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:03.040917) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:24:03.047845) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-25 05:24:03.048162) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:24:06 INFO - MultiFileLogger online at 20160425 05:24:06 in /builds/slave/test 05:24:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:24:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:24:06 INFO - {'append_to_log': False, 05:24:06 INFO - 'base_work_dir': '/builds/slave/test', 05:24:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:24:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:24:06 INFO - 'branch': 'Fx-Team-Non-PGO', 05:24:06 INFO - 'buildbot_json_path': 'buildprops.json', 05:24:06 INFO - 'config_files': ('talos/linux_config.py',), 05:24:06 INFO - 'default_actions': ('clobber', 05:24:06 INFO - 'read-buildbot-config', 05:24:06 INFO - 'download-and-extract', 05:24:06 INFO - 'populate-webroot', 05:24:06 INFO - 'create-virtualenv', 05:24:06 INFO - 'install', 05:24:06 INFO - 'run-tests'), 05:24:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:24:06 INFO - 'download_minidump_stackwalk': True, 05:24:06 INFO - 'download_symbols': 'ondemand', 05:24:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:24:06 INFO - 'tooltool.py': '/tools/tooltool.py', 05:24:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:24:06 INFO - '/tools/misc-python/virtualenv.py')}, 05:24:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:24:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:24:06 INFO - 'installer_path': 'installer.exe', 05:24:06 INFO - 'log_level': 'info', 05:24:06 INFO - 'log_name': 'talos', 05:24:06 INFO - 'log_to_console': True, 05:24:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:24:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:24:06 INFO - 'opt_config_files': (), 05:24:06 INFO - 'pip_index': False, 05:24:06 INFO - 'sps_profile': False, 05:24:06 INFO - 'sps_profile_interval': 0, 05:24:06 INFO - 'suite': 'dromaeojs-e10s', 05:24:06 INFO - 'system_bits': '32', 05:24:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:24:06 INFO - 'title': 'talos-linux64-ix-055', 05:24:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:24:06 INFO - 'use_talos_json': True, 05:24:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:24:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:24:06 INFO - 'work_dir': 'build'} 05:24:06 INFO - ##### 05:24:06 INFO - ##### Running clobber step. 05:24:06 INFO - ##### 05:24:06 INFO - Running pre-action listener: _resource_record_pre_action 05:24:06 INFO - Running main action method: clobber 05:24:06 INFO - rmtree: /builds/slave/test/build 05:24:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:24:07 INFO - Running post-action listener: _resource_record_post_action 05:24:07 INFO - ##### 05:24:07 INFO - ##### Running read-buildbot-config step. 05:24:07 INFO - ##### 05:24:07 INFO - Running pre-action listener: _resource_record_pre_action 05:24:07 INFO - Running main action method: read_buildbot_config 05:24:07 INFO - Using buildbot properties: 05:24:07 INFO - { 05:24:07 INFO - "project": "", 05:24:07 INFO - "product": "firefox", 05:24:07 INFO - "script_repo_revision": "production", 05:24:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:24:07 INFO - "repository": "", 05:24:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 05:24:07 INFO - "buildid": "20160422035423", 05:24:07 INFO - "pgo_build": "False", 05:24:07 INFO - "basedir": "/builds/slave/test", 05:24:07 INFO - "buildnumber": 1444, 05:24:07 INFO - "slavename": "talos-linux64-ix-055", 05:24:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:24:07 INFO - "platform": "ubuntu64_hw", 05:24:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:24:07 INFO - "branch": "fx-team", 05:24:07 INFO - "repo_path": "integration/fx-team", 05:24:07 INFO - "revision": "0361b7030d363459416d46e651a8c50c9536788f", 05:24:07 INFO - "stage_platform": "linux64", 05:24:07 INFO - "builduid": "e1d26a5cd477466bafcab7d720b7b498", 05:24:07 INFO - "slavebuilddir": "test" 05:24:07 INFO - } 05:24:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 05:24:07 INFO - Running post-action listener: _resource_record_post_action 05:24:07 INFO - ##### 05:24:07 INFO - ##### Running download-and-extract step. 05:24:07 INFO - ##### 05:24:07 INFO - Running pre-action listener: _resource_record_pre_action 05:24:07 INFO - Running main action method: download_and_extract 05:24:07 INFO - mkdir: /builds/slave/test/build/tests 05:24:07 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')]} 05:24:07 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:24:07 INFO - Downloaded 1361 bytes. 05:24:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 05:24:07 INFO - Using the following test package requirements: 05:24:07 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:24:07 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:24:07 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:24:07 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:07 INFO - u'jsshell-linux-x86_64.zip'], 05:24:07 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:24:07 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 05:24:07 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:24:07 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:24:07 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:24:07 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:07 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:24:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:24:07 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')]} 05:24:07 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:24:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:24:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:24:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:24:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:24:09 INFO - Downloaded 22281373 bytes. 05:24:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:24:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:24:10 INFO - Return code: 0 05:24:10 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:24: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')]} 05:24:10 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:24:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:24:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:24:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 05:24:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:24:11 INFO - Downloaded 22281373 bytes. 05:24:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:24:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:24:12 INFO - Return code: 0 05:24:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:12 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:24:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:24:13 INFO - Downloaded 10845952 bytes. 05:24:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:24:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:24:14 INFO - Return code: 0 05:24: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')]} 05:24:14 INFO - https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:24:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:24:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:24:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:24:15 INFO - Downloaded 54649298 bytes. 05:24:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:24:15 INFO - mkdir: /builds/slave/test/properties 05:24:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:15 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:15 INFO - Contents: 05:24:15 INFO - build_url:https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 05:24:16 INFO - Running post-action listener: _resource_record_post_action 05:24:16 INFO - Running post-action listener: set_extra_try_arguments 05:24:16 INFO - ##### 05:24:16 INFO - ##### Running populate-webroot step. 05:24:16 INFO - ##### 05:24:16 INFO - Running pre-action listener: _resource_record_pre_action 05:24:16 INFO - Running main action method: populate_webroot 05:24:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:24:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:24:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:24:16 INFO - '--tppagecycles', 05:24:16 INFO - '7'], 05:24:16 INFO - 'tests': ['tsvgm']}}, 05:24:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:24:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:24:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:24:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:24:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:16 INFO - 'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:16 INFO - 'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['damp', 'tps']}, 05:24:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:16 INFO - 'tests': ['damp', 'tps']}, 05:24:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['dromaeo_dom']}, 05:24:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['a11yr', 05:24:16 INFO - 'ts_paint', 05:24:16 INFO - 'tpaint', 05:24:16 INFO - 'sessionrestore', 05:24:16 INFO - 'sessionrestore_no_auto_restore', 05:24:16 INFO - 'tabpaint']}, 05:24:16 INFO - 'other-e10s': {'tests': ['a11yr', 05:24:16 INFO - 'ts_paint', 05:24:16 INFO - 'tpaint', 05:24:16 INFO - 'sessionrestore', 05:24:16 INFO - 'sessionrestore_no_auto_restore', 05:24:16 INFO - 'tabpaint']}, 05:24:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:24:16 INFO - 'ts_paint', 05:24:16 INFO - 'tpaint', 05:24:16 INFO - 'sessionrestore', 05:24:16 INFO - 'sessionrestore_no_auto_restore', 05:24:16 INFO - 'tabpaint']}, 05:24:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:24:16 INFO - 'ts_paint', 05:24:16 INFO - 'tpaint', 05:24:16 INFO - 'sessionrestore', 05:24:16 INFO - 'sessionrestore_no_auto_restore', 05:24:16 INFO - 'tabpaint']}, 05:24:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['a11yr', 05:24:16 INFO - 'ts_paint', 05:24:16 INFO - 'tpaint', 05:24:16 INFO - 'sessionrestore', 05:24:16 INFO - 'sessionrestore_no_auto_restore', 05:24:16 INFO - 'tabpaint']}, 05:24:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['a11yr', 05:24:16 INFO - 'ts_paint', 05:24:16 INFO - 'tpaint', 05:24:16 INFO - 'sessionrestore', 05:24:16 INFO - 'sessionrestore_no_auto_restore', 05:24:16 INFO - 'tabpaint']}, 05:24:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['tsvgx', 05:24:16 INFO - 'tsvgr_opacity', 05:24:16 INFO - 'tart', 05:24:16 INFO - 'tscrollx', 05:24:16 INFO - 'cart']}, 05:24:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:24:16 INFO - 'tsvgr_opacity', 05:24:16 INFO - 'tart', 05:24:16 INFO - 'tscrollx', 05:24:16 INFO - 'cart']}, 05:24:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:16 INFO - 'talos_options': ['--disable-e10s'], 05:24:16 INFO - 'tests': ['tp5o']}, 05:24:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:16 INFO - 'tests': ['tp5o']}, 05:24:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:16 INFO - 'talos_options': ['--disable-e10s', 05:24:16 INFO - '--xperf_path', 05:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:16 INFO - 'tests': ['tp5n']}, 05:24:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:16 INFO - 'talos_options': ['--xperf_path', 05:24:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:16 INFO - 'tests': ['tp5n']}}, 05:24:16 INFO - 'talos.zip': {'path': '', 05:24:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:24:16 INFO - Running post-action listener: _resource_record_post_action 05:24:16 INFO - ##### 05:24:16 INFO - ##### Running create-virtualenv step. 05:24:16 INFO - ##### 05:24:16 INFO - Running pre-action listener: _resource_record_pre_action 05:24:16 INFO - Running main action method: create_virtualenv 05:24:16 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:16 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 05:24:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:16 INFO - Using real prefix '/usr' 05:24:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:19 INFO - Installing pip.................done. 05:24:19 INFO - Return code: 0 05:24:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb31f7fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', '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 05:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:24:19 INFO - Using env: {'DISPLAY': ':0', 05:24:19 INFO - 'HOME': '/home/cltbld', 05:24:19 INFO - 'LANG': 'en_US.UTF-8', 05:24:19 INFO - 'LANGUAGE': 'en_US:en', 05:24:19 INFO - 'LOGNAME': 'cltbld', 05:24:19 INFO - 'MAIL': '/var/mail/cltbld', 05:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:19 INFO - 'MOZ_NO_REMOTE': '1', 05:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:19 INFO - 'NO_EM_RESTART': '1', 05:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:19 INFO - 'PWD': '/builds/slave/test', 05:24:19 INFO - 'SHELL': '/bin/bash', 05:24:19 INFO - 'SHLVL': '1', 05:24:19 INFO - 'TERM': 'linux', 05:24:19 INFO - 'TMOUT': '86400', 05:24:19 INFO - 'USER': 'cltbld', 05:24:19 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:19 INFO - '_': '/tools/buildbot/bin/python'} 05:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:19 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 05:24:19 INFO - Cleaning up... 05:24:19 INFO - Return code: 0 05:24:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb31f7fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', '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 05:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:24:19 INFO - Using env: {'DISPLAY': ':0', 05:24:19 INFO - 'HOME': '/home/cltbld', 05:24:19 INFO - 'LANG': 'en_US.UTF-8', 05:24:19 INFO - 'LANGUAGE': 'en_US:en', 05:24:19 INFO - 'LOGNAME': 'cltbld', 05:24:19 INFO - 'MAIL': '/var/mail/cltbld', 05:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:19 INFO - 'MOZ_NO_REMOTE': '1', 05:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:19 INFO - 'NO_EM_RESTART': '1', 05:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:19 INFO - 'PWD': '/builds/slave/test', 05:24:19 INFO - 'SHELL': '/bin/bash', 05:24:19 INFO - 'SHLVL': '1', 05:24:19 INFO - 'TERM': 'linux', 05:24:19 INFO - 'TMOUT': '86400', 05:24:19 INFO - 'USER': 'cltbld', 05:24:19 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:19 INFO - '_': '/tools/buildbot/bin/python'} 05:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:19 INFO - Downloading/unpacking psutil>=0.7.1 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:21 INFO - Installing collected packages: psutil 05:24:21 INFO - Running setup.py install for psutil 05:24:21 INFO - building 'psutil._psutil_linux' extension 05:24:21 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 05:24:21 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 05:24:21 INFO - building 'psutil._psutil_posix' extension 05:24:21 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 05:24:21 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 05:24:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:22 INFO - Successfully installed psutil 05:24:22 INFO - Cleaning up... 05:24:22 INFO - Return code: 0 05:24:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:22 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 0x7fb31f7fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', '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 05:24:22 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 05:24:22 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 05:24:22 INFO - Using env: {'DISPLAY': ':0', 05:24:22 INFO - 'HOME': '/home/cltbld', 05:24:22 INFO - 'LANG': 'en_US.UTF-8', 05:24:22 INFO - 'LANGUAGE': 'en_US:en', 05:24:22 INFO - 'LOGNAME': 'cltbld', 05:24:22 INFO - 'MAIL': '/var/mail/cltbld', 05:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:22 INFO - 'MOZ_NO_REMOTE': '1', 05:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:22 INFO - 'NO_EM_RESTART': '1', 05:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:22 INFO - 'PWD': '/builds/slave/test', 05:24:22 INFO - 'SHELL': '/bin/bash', 05:24:22 INFO - 'SHLVL': '1', 05:24:22 INFO - 'TERM': 'linux', 05:24:22 INFO - 'TMOUT': '86400', 05:24:22 INFO - 'USER': 'cltbld', 05:24:22 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:22 INFO - '_': '/tools/buildbot/bin/python'} 05:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:24:24 INFO - Installing collected packages: mozsystemmonitor 05:24:24 INFO - Running setup.py install for mozsystemmonitor 05:24:24 INFO - Successfully installed mozsystemmonitor 05:24:24 INFO - Cleaning up... 05:24:24 INFO - Return code: 0 05:24:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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', '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 0x7fb31f7fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', '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 05:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:24: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 blobuploader==1.2.4 05:24:24 INFO - Using env: {'DISPLAY': ':0', 05:24:24 INFO - 'HOME': '/home/cltbld', 05:24:24 INFO - 'LANG': 'en_US.UTF-8', 05:24:24 INFO - 'LANGUAGE': 'en_US:en', 05:24:24 INFO - 'LOGNAME': 'cltbld', 05:24:24 INFO - 'MAIL': '/var/mail/cltbld', 05:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:24 INFO - 'MOZ_NO_REMOTE': '1', 05:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:24 INFO - 'NO_EM_RESTART': '1', 05:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:24 INFO - 'PWD': '/builds/slave/test', 05:24:24 INFO - 'SHELL': '/bin/bash', 05:24:24 INFO - 'SHLVL': '1', 05:24:24 INFO - 'TERM': 'linux', 05:24:24 INFO - 'TMOUT': '86400', 05:24:24 INFO - 'USER': 'cltbld', 05:24:24 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:24 INFO - '_': '/tools/buildbot/bin/python'} 05:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24:26 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24:27 INFO - Downloading docopt-0.6.1.tar.gz 05:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:27 INFO - Running setup.py install for blobuploader 05:24:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:27 INFO - Running setup.py install for requests 05:24:27 INFO - Running setup.py install for docopt 05:24:27 INFO - Successfully installed blobuploader requests docopt 05:24:27 INFO - Cleaning up... 05:24:27 INFO - Return code: 0 05:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:27 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 0x7fb31f7fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', '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 05:24:27 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 05:24:27 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 05:24:27 INFO - Using env: {'DISPLAY': ':0', 05:24:27 INFO - 'HOME': '/home/cltbld', 05:24:27 INFO - 'LANG': 'en_US.UTF-8', 05:24:27 INFO - 'LANGUAGE': 'en_US:en', 05:24:27 INFO - 'LOGNAME': 'cltbld', 05:24:27 INFO - 'MAIL': '/var/mail/cltbld', 05:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:27 INFO - 'MOZ_NO_REMOTE': '1', 05:24:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:27 INFO - 'NO_EM_RESTART': '1', 05:24:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:27 INFO - 'PWD': '/builds/slave/test', 05:24:27 INFO - 'SHELL': '/bin/bash', 05:24:27 INFO - 'SHLVL': '1', 05:24:27 INFO - 'TERM': 'linux', 05:24:27 INFO - 'TMOUT': '86400', 05:24:27 INFO - 'USER': 'cltbld', 05:24:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:27 INFO - '_': '/tools/buildbot/bin/python'} 05:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:28 INFO - Running setup.py (path:/tmp/pip-S9haPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:28 INFO - Running setup.py (path:/tmp/pip-1RicwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:28 INFO - Running setup.py (path:/tmp/pip-F9qiXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:28 INFO - Running setup.py (path:/tmp/pip-ePZma7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:28 INFO - Running setup.py (path:/tmp/pip-RnPdBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:28 INFO - Running setup.py (path:/tmp/pip-YeYYIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:28 INFO - Running setup.py (path:/tmp/pip-hXzRxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:28 INFO - Running setup.py (path:/tmp/pip-TYwpYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:28 INFO - Running setup.py (path:/tmp/pip-0bZwOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:28 INFO - Running setup.py (path:/tmp/pip-mZegAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:28 INFO - Running setup.py (path:/tmp/pip-zjGtdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:28 INFO - Running setup.py (path:/tmp/pip-TlcT3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:28 INFO - Running setup.py (path:/tmp/pip-BOrktP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:28 INFO - Running setup.py (path:/tmp/pip-BKO8Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:29 INFO - Running setup.py (path:/tmp/pip-iH2PhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:29 INFO - Running setup.py (path:/tmp/pip-tlmwa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:29 INFO - Running setup.py (path:/tmp/pip-nnELDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:29 INFO - Running setup.py install for manifestparser 05:24:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:29 INFO - Running setup.py install for mozcrash 05:24:29 INFO - Running setup.py install for mozdebug 05:24:29 INFO - Running setup.py install for mozdevice 05:24:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:29 INFO - Running setup.py install for mozfile 05:24:29 INFO - Running setup.py install for mozhttpd 05:24:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:29 INFO - Running setup.py install for mozinfo 05:24:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:29 INFO - Running setup.py install for mozInstall 05:24:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozleak 05:24:30 INFO - Running setup.py install for mozlog 05:24:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for moznetwork 05:24:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozprocess 05:24:30 INFO - Running setup.py install for mozprofile 05:24:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozrunner 05:24:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:30 INFO - Running setup.py install for mozscreenshot 05:24:30 INFO - Running setup.py install for moztest 05:24:30 INFO - Running setup.py install for mozversion 05:24:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:31 INFO - Cleaning up... 05:24:31 INFO - Return code: 0 05:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:31 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 0x7fb31f7fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', '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 05:24:31 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 05:24:31 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 05:24:31 INFO - Using env: {'DISPLAY': ':0', 05:24:31 INFO - 'HOME': '/home/cltbld', 05:24:31 INFO - 'LANG': 'en_US.UTF-8', 05:24:31 INFO - 'LANGUAGE': 'en_US:en', 05:24:31 INFO - 'LOGNAME': 'cltbld', 05:24:31 INFO - 'MAIL': '/var/mail/cltbld', 05:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:31 INFO - 'MOZ_NO_REMOTE': '1', 05:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:31 INFO - 'NO_EM_RESTART': '1', 05:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:31 INFO - 'PWD': '/builds/slave/test', 05:24:31 INFO - 'SHELL': '/bin/bash', 05:24:31 INFO - 'SHLVL': '1', 05:24:31 INFO - 'TERM': 'linux', 05:24:31 INFO - 'TMOUT': '86400', 05:24:31 INFO - 'USER': 'cltbld', 05:24:31 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:31 INFO - '_': '/tools/buildbot/bin/python'} 05:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:31 INFO - Running setup.py (path:/tmp/pip-VIDfAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:31 INFO - Running setup.py (path:/tmp/pip-5uNS38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:31 INFO - Running setup.py (path:/tmp/pip-iIyf3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:31 INFO - Running setup.py (path:/tmp/pip-V7v0Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:31 INFO - Running setup.py (path:/tmp/pip-xa_sJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:31 INFO - Running setup.py (path:/tmp/pip-EBqOpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:31 INFO - Running setup.py (path:/tmp/pip-7NduXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:31 INFO - Running setup.py (path:/tmp/pip-vzvnOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:31 INFO - Running setup.py (path:/tmp/pip-0Z71HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:31 INFO - Running setup.py (path:/tmp/pip-5LKmfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:31 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)) 05:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:31 INFO - Running setup.py (path:/tmp/pip-0rKv70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:32 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)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:32 INFO - Running setup.py (path:/tmp/pip-7Ix8eH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:32 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)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:32 INFO - Running setup.py (path:/tmp/pip-YCtXQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:32 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)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:32 INFO - Running setup.py (path:/tmp/pip-Kmzc0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:32 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)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:32 INFO - Running setup.py (path:/tmp/pip-dHuBXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:32 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)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:32 INFO - Running setup.py (path:/tmp/pip-jDKsVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:32 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)) 05:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:32 INFO - Running setup.py (path:/tmp/pip-bd2DWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:32 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)) 05:24:32 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)) 05:24:32 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)) 05:24:32 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)) 05:24:32 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)) 05:24:32 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)) 05:24:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:34 INFO - Downloading blessings-1.6.tar.gz 05:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:34 INFO - Installing collected packages: blessings 05:24:34 INFO - Running setup.py install for blessings 05:24:34 INFO - Successfully installed blessings 05:24:34 INFO - Cleaning up... 05:24:34 INFO - Return code: 0 05:24:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:34 INFO - Reading from file tmpfile_stdout 05:24:34 INFO - Current package versions: 05:24:34 INFO - argparse == 1.2.1 05:24:34 INFO - blessings == 1.6 05:24:34 INFO - blobuploader == 1.2.4 05:24:34 INFO - docopt == 0.6.1 05:24:34 INFO - manifestparser == 1.1 05:24:34 INFO - mozInstall == 1.12 05:24:34 INFO - mozcrash == 0.17 05:24:34 INFO - mozdebug == 0.1 05:24:34 INFO - mozdevice == 0.48 05:24:34 INFO - mozfile == 1.2 05:24:34 INFO - mozhttpd == 0.7 05:24:34 INFO - mozinfo == 0.9 05:24:34 INFO - mozleak == 0.1 05:24:34 INFO - mozlog == 3.1 05:24:34 INFO - moznetwork == 0.27 05:24:34 INFO - mozprocess == 0.22 05:24:34 INFO - mozprofile == 0.28 05:24:34 INFO - mozrunner == 6.11 05:24:34 INFO - mozscreenshot == 0.1 05:24:34 INFO - mozsystemmonitor == 0.0 05:24:34 INFO - moztest == 0.7 05:24:34 INFO - mozversion == 1.4 05:24:34 INFO - psutil == 3.1.1 05:24:34 INFO - requests == 1.2.3 05:24:34 INFO - wsgiref == 0.1.2 05:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:34 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')]} 05:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:34 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')]} 05:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:34 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 0x7fb31f7fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', '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 05:24:34 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 05:24:34 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 05:24:34 INFO - Using env: {'DISPLAY': ':0', 05:24:34 INFO - 'HOME': '/home/cltbld', 05:24:34 INFO - 'LANG': 'en_US.UTF-8', 05:24:34 INFO - 'LANGUAGE': 'en_US:en', 05:24:34 INFO - 'LOGNAME': 'cltbld', 05:24:34 INFO - 'MAIL': '/var/mail/cltbld', 05:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:34 INFO - 'MOZ_NO_REMOTE': '1', 05:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:34 INFO - 'NO_EM_RESTART': '1', 05:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:34 INFO - 'PWD': '/builds/slave/test', 05:24:34 INFO - 'SHELL': '/bin/bash', 05:24:34 INFO - 'SHLVL': '1', 05:24:34 INFO - 'TERM': 'linux', 05:24:34 INFO - 'TMOUT': '86400', 05:24:34 INFO - 'USER': 'cltbld', 05:24:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:34 INFO - '_': '/tools/buildbot/bin/python'} 05:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:35 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)) 05:24:35 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)) 05:24:35 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)) 05:24:35 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)) 05:24:35 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)) 05:24:35 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)) 05:24:35 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)) 05:24:35 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)) 05:24:35 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)) 05:24:35 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)) 05:24:35 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)) 05:24:35 INFO - Cleaning up... 05:24:35 INFO - Return code: 0 05:24:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:35 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 0x7fb31f7fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', '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 05:24:35 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 05:24:35 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 05:24:35 INFO - Using env: {'DISPLAY': ':0', 05:24:35 INFO - 'HOME': '/home/cltbld', 05:24:35 INFO - 'LANG': 'en_US.UTF-8', 05:24:35 INFO - 'LANGUAGE': 'en_US:en', 05:24:35 INFO - 'LOGNAME': 'cltbld', 05:24:35 INFO - 'MAIL': '/var/mail/cltbld', 05:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:35 INFO - 'MOZ_NO_REMOTE': '1', 05:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:35 INFO - 'NO_EM_RESTART': '1', 05:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:35 INFO - 'PWD': '/builds/slave/test', 05:24:35 INFO - 'SHELL': '/bin/bash', 05:24:35 INFO - 'SHLVL': '1', 05:24:35 INFO - 'TERM': 'linux', 05:24:35 INFO - 'TMOUT': '86400', 05:24:35 INFO - 'USER': 'cltbld', 05:24:35 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:35 INFO - '_': '/tools/buildbot/bin/python'} 05:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:35 INFO - Downloading/unpacking jsonschema 05:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:37 INFO - Downloading/unpacking functools32 (from jsonschema) 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:37 INFO - warning: no files found matching '*.txt' 05:24:37 INFO - no previously-included directories found matching 'build' 05:24:37 INFO - no previously-included directories found matching 'dist' 05:24:37 INFO - no previously-included directories found matching '.git*' 05:24:37 INFO - Installing collected packages: jsonschema, functools32 05:24:37 INFO - Running setup.py install for functools32 05:24:37 INFO - warning: no files found matching '*.txt' 05:24:37 INFO - no previously-included directories found matching 'build' 05:24:37 INFO - no previously-included directories found matching 'dist' 05:24:37 INFO - no previously-included directories found matching '.git*' 05:24:37 INFO - Successfully installed jsonschema functools32 05:24:37 INFO - Cleaning up... 05:24:37 INFO - Return code: 0 05:24:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:24:37 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')]} 05:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:37 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')]} 05:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:37 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 0x7fb31f7fef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198c5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, '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': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', '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 05:24:37 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 05:24:37 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 05:24:37 INFO - Using env: {'DISPLAY': ':0', 05:24:37 INFO - 'HOME': '/home/cltbld', 05:24:37 INFO - 'LANG': 'en_US.UTF-8', 05:24:37 INFO - 'LANGUAGE': 'en_US:en', 05:24:37 INFO - 'LOGNAME': 'cltbld', 05:24:37 INFO - 'MAIL': '/var/mail/cltbld', 05:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:37 INFO - 'MOZ_NO_REMOTE': '1', 05:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:37 INFO - 'NO_EM_RESTART': '1', 05:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:37 INFO - 'PWD': '/builds/slave/test', 05:24:37 INFO - 'SHELL': '/bin/bash', 05:24:37 INFO - 'SHLVL': '1', 05:24:37 INFO - 'TERM': 'linux', 05:24:37 INFO - 'TMOUT': '86400', 05:24:37 INFO - 'USER': 'cltbld', 05:24:37 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:37 INFO - '_': '/tools/buildbot/bin/python'} 05:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:37 INFO - Downloading/unpacking flake8 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:37 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 05:24:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:24:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:24:39 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 05:24:39 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 05:24:39 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 05:24:39 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 05:24:39 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 05:24:39 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 05:24:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:24:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:24:40 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 05:24:40 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 05:24:40 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 05:24:40 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 05:24:40 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 05:24:40 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 05:24:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:24:40 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 05:24:40 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 05:24:40 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 05:24:40 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 05:24:40 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 05:24:40 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 05:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:24:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:40 INFO - no previously-included directories found matching 'docs/_build' 05:24:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:24:40 INFO - Running setup.py install for pep8 05:24:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:24:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:24:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:24:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:24:40 INFO - no previously-included directories found matching 'docs/_build' 05:24:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:24:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:24:40 INFO - Cleaning up... 05:24:40 INFO - Return code: 0 05:24:40 INFO - Running post-action listener: _resource_record_post_action 05:24:40 INFO - Running post-action listener: _start_resource_monitoring 05:24:40 INFO - Starting resource monitoring. 05:24:40 INFO - ##### 05:24:40 INFO - ##### Running install step. 05:24:40 INFO - ##### 05:24:40 INFO - Running pre-action listener: _resource_record_pre_action 05:24:40 INFO - Running main action method: install 05:24:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:41 INFO - Reading from file tmpfile_stdout 05:24:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:41 INFO - Reading from file tmpfile_stdout 05:24:41 INFO - Output received: 05:24:41 INFO - Usage: mozinstall [options] installer 05:24:41 INFO - Options: 05:24:41 INFO - -h, --help show this help message and exit 05:24:41 INFO - -d DEST, --destination=DEST 05:24:41 INFO - Directory to install application into. [default: 05:24:41 INFO - "/builds/slave/test"] 05:24:41 INFO - --app=APP Application being installed. [default: firefox] 05:24:41 INFO - mkdir: /builds/slave/test/build/application 05:24:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:24:56 INFO - Reading from file tmpfile_stdout 05:24:56 INFO - Output received: 05:24:56 INFO - /builds/slave/test/build/application/firefox/firefox 05:24:56 INFO - Running post-action listener: _resource_record_post_action 05:24:56 INFO - ##### 05:24:56 INFO - ##### Running run-tests step. 05:24:56 INFO - ##### 05:24:56 INFO - Running pre-action listener: _resource_record_pre_action 05:24:56 INFO - Running main action method: run_tests 05:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:24:56 INFO - Python 2.7.3 05:24:56 INFO - Return code: 0 05:24:56 INFO - grabbing minidump binary from tooltool 05:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:56 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 0x1a1b410>, '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 0x1a1c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:24:56 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 05:24:56 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 05:24:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:24:56 INFO - Return code: 0 05:24:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:24:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:24:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:24:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:24:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:24:57 INFO - Return code: 0 05:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:24:57 INFO - Using env: {'DISPLAY': ':0', 05:24:57 INFO - 'HOME': '/home/cltbld', 05:24:57 INFO - 'LANG': 'en_US.UTF-8', 05:24:57 INFO - 'LANGUAGE': 'en_US:en', 05:24:57 INFO - 'LOGNAME': 'cltbld', 05:24:57 INFO - 'MAIL': '/var/mail/cltbld', 05:24:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:57 INFO - 'MOZ_NO_REMOTE': '1', 05:24:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:57 INFO - 'NO_EM_RESTART': '1', 05:24:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:57 INFO - 'PWD': '/builds/slave/test', 05:24:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:57 INFO - 'SHELL': '/bin/bash', 05:24:57 INFO - 'SHLVL': '1', 05:24:57 INFO - 'TERM': 'linux', 05:24:57 INFO - 'TMOUT': '86400', 05:24:57 INFO - 'USER': 'cltbld', 05:24:57 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977', 05:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:57 INFO - '_': '/tools/buildbot/bin/python'} 05:24:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:24:58 INFO - mozversion application_buildid: 20160422035423 05:24:58 INFO - mozversion application_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:24:58 INFO - mozversion application_display_name: Nightly 05:24:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:24:58 INFO - mozversion application_name: Firefox 05:24:58 INFO - mozversion application_remotingname: firefox 05:24:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:24:58 INFO - mozversion application_vendor: Mozilla 05:24:58 INFO - mozversion application_version: 48.0a1 05:24:58 INFO - mozversion platform_buildid: 20160422035423 05:24:58 INFO - mozversion platform_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:24:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:24:58 INFO - mozversion platform_version: 48.0a1 05:24:58 INFO - using testdate: 1461587098 05:24:58 INFO - actual date: 1461587098 05:24:58 INFO - starting webserver on 'localhost:41675' 05:24:58 INFO - SUITE-START | Running 2 tests 05:24:58 INFO - TEST-START | dromaeo_css 05:24:58 INFO - operating with platform_type : linux_ 05:24:58 INFO - Initialising browser for dromaeo_css test... 05:24:58 INFO - TEST-INFO | started process 16611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCiFFU5/profile http://localhost:41675/getInfo.html) 05:25:02 INFO - PROCESS | 16611 | 05:25:02 INFO - PROCESS | 16611 | (process:16676): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:25:02 INFO - PROCESS | 16611 | __metrics Screen width/height:1600/1200 05:25:02 INFO - PROCESS | 16611 | colorDepth:24 05:25:02 INFO - PROCESS | 16611 | Browser inner width/height: 1024/697 05:25:02 INFO - PROCESS | 16611 | __metrics 05:25:03 ERROR - PROCESS | 16611 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:25:04 INFO - TEST-INFO | 16611: exit 0 05:25:04 INFO - Browser initialized. 05:25:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:04 INFO - TEST-INFO | started process 16727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCiFFU5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:06 INFO - PROCESS | 16727 | 05:25:06 INFO - PROCESS | 16727 | (process:16789): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:25:16 INFO - PROCESS | 16727 | RSS: Main: 164966400 05:25:16 INFO - PROCESS | 16727 | 05:26:06 INFO - PROCESS | 16727 | 1461587166045 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] 05:28:17 INFO - PROCESS | 16727 | Cycle 1(1): loaded http://localhost:41675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41675/tests/dromaeo/cssquery-ext.html) 05:28:18 INFO - PROCESS | 16727 | RSS: Main: 169443328 05:28:18 INFO - PROCESS | 16727 | 05:31:20 INFO - PROCESS | 16727 | Cycle 1(1): loaded http://localhost:41675/tests/dromaeo/cssquery-ext.html (next: http://localhost:41675/tests/dromaeo/cssquery-jquery.html) 05:31:21 INFO - PROCESS | 16727 | RSS: Main: 166432768 05:31:21 INFO - PROCESS | 16727 | 05:34:23 INFO - PROCESS | 16727 | Cycle 1(1): loaded http://localhost:41675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41675/tests/dromaeo/cssquery-mootools.html) 05:34:23 INFO - PROCESS | 16727 | RSS: Main: 167272448 05:34:23 INFO - PROCESS | 16727 | 05:37:25 INFO - PROCESS | 16727 | Cycle 1(1): loaded http://localhost:41675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41675/tests/dromaeo/cssquery-prototype.html) 05:37:26 INFO - PROCESS | 16727 | RSS: Main: 165191680 05:37:26 INFO - PROCESS | 16727 | 05:40:29 INFO - PROCESS | 16727 | Cycle 1(1): loaded http://localhost:41675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41675/tests/dromaeo/cssquery-yui.html) 05:40:29 INFO - PROCESS | 16727 | RSS: Main: 166662144 05:40:29 INFO - PROCESS | 16727 | 05:43:32 INFO - PROCESS | 16727 | Cycle 1(1): loaded http://localhost:41675/tests/dromaeo/cssquery-yui.html (next: http://localhost:41675/tests/dromaeo/cssquery-dojo.html) 05:43:32 INFO - PROCESS | 16727 | RSS: Main: 168288256 05:43:32 INFO - PROCESS | 16727 | 05:43:32 INFO - PROCESS | 16727 | __start_tp_report 05:43:32 INFO - PROCESS | 16727 | _x_x_mozilla_page_load 05:43:32 INFO - PROCESS | 16727 | _x_x_mozilla_page_load_details 05:43:32 INFO - PROCESS | 16727 | |i|pagename|runs| 05:43:32 INFO - PROCESS | 16727 | |0;dojo.html;2636;2675.3712877473795;2701;2713.131797824697;2713.5386984212682;4822;4823.999999999995;4826.227803551433;4836.540528649773;4842.201036828923;4672.509386514418;4808.927866082012;4813.350197723306;4878.170710979133;4886.8778280543;4417.51407345191;4442;4499.527549607294;4507.053518761064;4547.204239258117;603.5635157381392;4301.612854843063;4443.60007599316;4458.531854155316;4476.597106260436;4415.580519850609;4420.20436321462;4434.290513517822;4442.244818380883;4467.419235499365;4367.781610919441;4503.527129651405;4521.050579378334;4523.886902827423;4539.205639013159;4365.978170109161;4378.562143785628;4409.250427427345;4433.556644335541;4445.022095139064;4679.976600117012;4685.5314468553215;4722.409698787652;4752.500987396343;4772.594329481998;5048.469910659364;5143.588512918957;5179.507946745053;5203.8178663746585;5260.842174734764;5148.433672296044;5149.9742501287255;5152.665076770036;5161.303224064741;5221.451747566489;4812.181929072031;4814.975925120352;4829.251466022772;4846.000784014078;4873.366462359871;5269.762860671279;5330.093884039723;5349.063913815066;5400.945990540123;5408.188771684278;5084.618653600995;5093.286939828427;5100.846974590768;5113.386393632788;5160.019596276696;4962.255661650709;5180.81867134656;5184.14461613837;5186.974065129651;5202.167653175474;5060.240963855377;5081.5426611605135;5102.770375333119;5154.639175257771;5168.302279192336;4999.325091112726;5151.639385243072;5189.584833213334;5189.974050129726;5241.9213711794355;4255.787210639455;4304.053108316165;4320.157569273962;4325.3728209409455;4367.47590289161;3736.1220113273357;3780.678642315379;3796.6583007529457;3818.5417749870194;3822.9044273893373;4425.977870110629;4428.2914733642465;4432.645388368923;4444.622207112432;4472.39622650938;5088.465711100355;5114.846554603368;5127.769250383742;5130.461301563282;5160.870978225575;4428.446444194476;4448.755318457451;4463.509014008457;4486.2597671383855;4506.7070640408265;4618.214903466419;4620.953790462119;4621.168189725814;4627.236505976476;4651.093036857848;4777.665563410528;4846.176150054429;4847.636427267969;4877.073356062337;4938.728369939688;5178.249153872592;5185.455527169744;5197.0905091608065;5205.297284866495;5234.371875374979;4843.806247750051;4852.053849499313;4852.684575502581;4857.077155340474;4898.093852637274;5014.473480284663;5065.39215294167;5108.361454818148;5181.3005244291535;5186.948130518646;5177.689338639693;5207.3490813648295;5209.7395130244095;5213.713245771367;5214.113600687816;5046.116929537389;5047.545720885138;5059.747012649279;5063.291139240583;5072.797088116582;4903.60771138301;4945.530174633404;5050.72221027847;5111.79552817898;5121.820736274212;4887.144749668722;4889.657723959289;4906.63200259989;4941.678790878582;4982.925256121233;5089.821856235014;5092.516210959953;5114.411842638145;5115.079285728456;5169.586433085269;4866.148424025852;4974.602031837517;5003.724795136302;5009.899802003866;5064.949350506447 05:43:32 INFO - PROCESS | 16727 | |1;ext.html;577.356247783721;602.2141105856857;610.6244659534385;620.5687047501985;637.751277001969;33981.66018339819;35048.82475587619;35070.82464587673;35336.82331588342;35386.292274154504;35210.119747006334;35870.103247418825;36163.2767344653;36181.63818361815;36198;7496.437767167471;7642.847143057135;7648.158702542716;7657.119431265392;7663.27198916102;7402;7649.6940122395035;7661.118971318314;7676.692932282702;7689.50018248812;7654.808629784272;7667.118281397627;7680.539167649931;7684.07791065073;7708.498947568418;7598.544087354749;7614.505057171266;7619.238076192391;7652.273034061783;7655.961720191392;7526.962365188194;7615.885761713524;7622.504537205064;7630.618469076524;7650.655720492591;29068.27329316763;35279.1180220494;35652.28695426103;35727.4640880387;35843.64156358429;2815.5635876439183;3051.6948305169303;3137.7803553751246;3392.932141357184;3612.24142929985;24896.875515622487;25153.496930061297;25376.873115634302;25519;25536.106236281827;3418.9145271368166;3484.9633056796515;3496.8251587420527;3568.9107772305642;3589.7846129232066;203091;204135;204272;204591.99999999852;204673;32075.198120047186;33074.3385132296;48367.75816120967;49165.50834491681;49716.254256186185;31567;31604.683953160173;31734.523982140287;31745.04764857058;31869;11755.823662645067;11821.172517923835;11833.822492662617;11838.644840654793;11854.703632409086;9747.317687761788;9764;9827.213822894151;9887.30788844774;9932.155766759763;7889.487183333065;7910.16943220965;7952.403569732293;8002.119766825645;8023.197680232047;3185.649578546358;3189.649138594753;3218.6935656061078;3221.1785994571233;3226.3708576827294;906.5467266366817;919.4529255093208;949.3212353167519;982.2485798364257;1028.1466382902322;25844.612330815053;27108;27271.181864544094;27345.31636709098;27477.31306717348;956.32101208143;997.3344514660389;1002.308407199045;1011.9696409107592;1054.9103326217205;14413.855861441461;14577.641137530105;14715.92642036783;14853.331600078023;14935.402583896739;331705;337666;340558;341655;344960;48351.75824120857;48713;48862.75568622134;49306.75346623316;49338.50661493411;1157.6642773595563;1193.803022501295;1213.4600102954278;1214.9028077753758;1220.7741567809983;25790.09734659278;26547.33631659224;26907.192784216506;27485.86257068702;27607.309817253925;42258.78870605627;42873;43048;43157.3526397098;43321;254959;255262;257245;312651;314602;24865.87567062153;25078.49843003166;25297.74702252954;25373;25414.872925635995;40009.1998160041;40328.79835600803;40687.593124069565;41079.17841643091;41340.1731965353;35091.82454087713;35659.46510802288;36278;36346.8182659085;36621;35699.28601427905;36200.456993144595;36250.27499450049;36407.45388819117;36521.45217821788;35251.82374088113;35619.46570801388;36054.63945360513;37394.43908341323;37548.812255938545;27263;31746.365072697954;33393.83303083469;33794.94460664736;34110.65889341174;24033.27900162998;24152.75847241505;24351.51296974086;24367.51264974726;24632 05:43:32 INFO - PROCESS | 16727 | |2;jquery.html;378.0510917596833;379.7778299694679;382.18213024128363;382.6766382406867;394.88745707473373;15763.290651920663;16291.592710182236;17074.402395916146;17131.828681713178;17145.314187432505;16798.244079016444;17481.125943702827;17632.8538644988;17750.911245443756;17856.375026874062;5745.741441635126;5907.350191478934;5915.9704201478935;5947.464728174464;5970.701464926758;3980.4825372701653;6706.798796036127;7077.327653872874;7122.1453425589;7129.928700713004;6856.965715171417;6957.721691132374;7066.681999310018;7087.89368159478;7120.50156489046;6728.663566821689;7028.54314469563;7075.787726368191;7094.432445404355;7105.7157713691395;6812.62530560819;6862.210845752752;6924.58452492852;6930.272321406281;6934.514583979124;20702.447316451176;21177.15291388358;21662.675059874113;22005.889970550044;22741.545169096524;1992.8505362097756;1999.240288690303;2180.226019762993;2184.847060705751;2743.3553115017953;13606.31968401576;13783.173009619455;14063.718725625533;14089.506867259699;15117.244137793066;1855.1280897977929;1887.962240755191;1944.7277381166648;1955.687090065597;1984.5534754680082;60620;62584;64925.35074649288;78317;82330.58834705788;14668.912401353533;16517.669646607;16723;16723.411275928767;16859.157042147843;29792.404151917275;29923.70076299253;29951.850240748656;30149.849250754043;30248.84875575608;8483.83032339362;8897.466152030769;9029.458232506071;9084.273258139334;9099.81800363989;7224.927750722531;7244.166920804069;7265.745698900513;7355.963220183972;7413.851722965511;3592.6227746086806;3968.146848427602;8331.416800824005;8463.449875758057;8504.31965442763;1878.549148204421;1910.178623192013;1917.3864363403857;1923.5768131011155;1934.9129289182022;842.6966292134827;869.2698133567707;894.561664784251;922.6078916460477;942.5569982108398;15381.154036527874;15555.611109722347;15710.135942523042;15838.76241856373;16010.599735006717;877.7937184761576;881.3830318776882;887.4896934262824;928.9256859451227;938.4463166731662;9173.266138708887;9314.301427392837;9466.715998520056;9682.612695492102;9686.78915135608;399807;403028;405089;414173;415321;44189.558104419186;44362.778186108866;45439.545604543535;46554.767226163654;47544.286835697494;860.6858496648678;863.9395242332977;874.9518776467355;878.9604467798964;891.0065277215987;14808.92754492523;14812.333444994785;14912.328945197276;14980.700385992437;14999.475018374305;33684.49473257854;34725.652743472245;35192.47211291884;36401.817990909876;36540.903772885795;48431.5156848427;50362.2445663308;50570;50862.491375085774;50932.74533627308;7606.695732170651;7726.304632583095;7731.845363092819;7739.264769846855;7820.5307681537015;10448.582056717647;11268.154888383568;11276.830847537129;11395.430228488376;11652.825207621723;9439.442491988744;9684.661036863676;9713.125818676353;9969.800603987735;10131.392116473035;9476.431414115175;9759.463229522444;9999.150072243941;10124.493775311057;10164.695059148238;9839.163671088038;10035.297529172887;10107.444090575089;10274.383536987805;10360.68917932433;7292.744753933587;7611.885821712568;7825.3739700824935;7850.960745196237;7886.881696774668;9358.409070457903;9562.18721408688;9600.32797704154;9630.422174669542;10102.949485252526 05:43:32 INFO - PROCESS | 16727 | |3;mootools.html;1437.3172742947102;1446.5660301909427;1530.5867415797734;1690.6280618263977;1729.7405389191626;7022.5435346702425;7590.77227683169;7681.615919204039;7979.481333713305;7998.920010799898;7730.65212065457;7810.804729881742;7915.604219789002;7933.801654958629;7950.562719050465;2270.6026445372117;2337.345543247893;2337.520808234308;2337.544178885118;2339.812814974798;2278.6354183330586;2298.8735619540917;2329.6505524171425;2341.0635745701684;2342.543204075206;2311.399036250579;2339.730930942938;2346.143657564985;2347.3779448446176;2348.8590684558894;2242.4281808138903;2246.0454306919573;2255.5037891663806;2256.627656436686;2283.041122728458;2230.3309007297908;2249.089118906845;2258.559580881729;2266.909323627053;2272.034385386221;7976.401769867225;8017.639206235734;8021.719239826636;8059.274665280094;8076.4750291230885;4780.330753694486;4952.405711314629;4975;4978.452370239271;4996.7501624918605;2947.8378689172087;2954.1137658702305;3056.144279601715;3057.4649436348773;3070.0482850316475;969.5782334684435;974.5614473486959;979.4466126638426;998.2862253488718;1017.7811770469384;10526.631567895087;10730.302530335503;10770.192235582363;10786.406747628876;10833.241673082888;4399.14216727735;4477.395551600557;4655.674102812838;4664.440267167962;4691.132140554008;9256.07439256069;9258.768530786785;9270.490123043162;9275.72172834816;9323.440593564408;4899.8285060023445;4905.852824415273;4906.632002599819;4920.778564964585;4936.456989731127;3781.0925377909653;4313.439252897166;4445.711028783118;4447;4452.0205554777895;3633.454981752758;3663.6336366363685;3716.6283371662616;3768.095657042345;3779.4897688811657;1217.4034722985673;1234.7098431868503;1240.8324876141785;1241.6399244219256;1247.681841130506;772.1660606544918;780.3328154427996;783.1815752538611;783.5494590610308;798.0383637716537;4944.876378090505;5164;5274.947250527445;5382.434844341366;5532.197831314437;828.4615000249886;867.6876324523166;883.1565854608833;900.7838118851429;906.2342320738965;3522.6653467920505;3566.8573257069947;3655.6527129922615;3698.2973235085246;3750.8499660013294;9505.194013137481;9785.07041831025;9865.457399842933;9910.950445247727;9913.157381622643;9729.756756081155;9736.123748862494;9736.123748862636;9797.755056123511;9809.460479673686;7395.149557800814;7578.355839753573;7595.734149304858;7611.467197296136;7641.350485208708;4880.097182021337;4966.379202599675;5130.153524668388;5168.0697474454955;5317.8404647860625;9044.231240344645;9059.773505662148;9135.817283654156;9171.266298695955;9181.265498759949;9101.135392137736;9174.862377064215;9327.16055554976;9336.066393360881;9377.718668439958;6130.356312587114;6130.356312587292;6583.177102862142;6880;6886.345797149263;7438.5536867788105;7463.888041679488;7472.178060413242;7474.5888976106835;7556.093268807778;6605.372489613671;6781.864362712817;6809.319068093349;6871.175458944958;6884.896726549206;6610.8016759497295;6648.434883034803;6725.932740672531;6753.15585551806;6849.691763870737;5991.460768530853;6215.471684906834;6250.656213908279;6276.403741644536;6347.777827776005;4125.711200215956;4155.8753237402925;4170.332746760504;4230.640395566411;4236.195122926757;4314.115606300764;4324.978375108104;4355.934660980151;4390.670699697472;4426.867193984185 05:43:32 INFO - PROCESS | 16727 | |4;prototype.html;317.63630642913864;319.29913839123117;322.3166886201252;324.98862539811114;326.7010685223021;5327.360716713995;5408.161734931087;5420.4850539198815;5420.647657902244;5440.374356948947;5342.813001544947;5344.385395679498;5347.171188465794;5355.196720491928;5362.65142765721;3930.469386632804;4031.8387264509383;4125.938110928339;4139.461869956916;4166.10428757817;4152.854650087247;4165.958340416587;4177.707560470768;4180.79096045198;4183.686223533247;4151.854685086023;4153.460050193486;4159.313713237312;4159.750414975096;4160.292750232467;4045.4336392905016;4148.668106551469;4167.291560434718;4169.958300417018;4178.603032711888;3668.5414323209598;3680.2639472105684;3681.613430589803;3682.5949145593963;3689.9631003689888;5109.259157422153;5131.692098474104;5139.229115632647;5153.1497302945345;5163.096458119851;4411.977940110311;4694.741789201593;4797.232442809169;4818.277258411266;4818.542238487338;5533.806316778893;5536.2249285100115;5640.294963129609;5644.040513112781;5648.604597678164;3919.902002449933;3920.7255492115564;3926.155876486569;3930.744501607386;3942.7240093193486;5805.158252053471;5845.81768112907;5903.173555702205;5965.701714914237;5982.102684597302;4001.099752555652;4023.436718859362;4033.6369726724733;4035.5762644922447;4044.292248856438;4075.59244075596;4089.5501494835544;4089.591040895946;4091.217971779159;4095.9385609215888;4601.654875884322;4703.247480403119;4707.646926480527;4709.222978208626;4713.929291060636;5644.181593668895;5671.546276297886;5674.319081710221;5697.686627235542;5701.686407247641;1382.5437605590132;1403.733290674789;1420.4105296302125;1422.9217393043482;1424.1383962702623;858;917.8485549884327;943.2736792669606;960.8709766024892;963.7157038673608;4817.975910120427;4901.362822833009;4914.72968986702;4917.139500587383;4930.9506904930495;5731.340895797037;5762.625429347163;5788.957987562195;5800.158976948319;5810.738516766755;4759.16714574948;4859.2954021666665;4882.438519570223;4897.681650692693;4914.459409464956;3097.5818264534;3102.193429708292;3117.298607813224;3124.375124975014;3136.325689976666;5380.166074258496;5381.408045115034;5388.46115388458;5397.8380648580605;5414.8104816332025;5773.88452230953;5866.882662346729;5960.791372301948;5965.7613695452565;5979.372165922602;5355.3841308249275;5399.946000540023;5405.162199859028;5406.864828379244;5413.431589683027;5552.805651802168;5759.7408116634015;5776.191333213437;5794;5820.679862607428;5684.090545512699;5687.289088863892;5696.458836410535;5705.144228365778;5709.743061562157;5323.361196656426;5378.650387724785;5404.83785486436;5443.564514838724;5454.100073487989;3803.8668646597234;3993.4209539616013;4009.318415869251;4035.071933455263;4062.8374865005067;5780.653160810197;5812.505936995402;5817.331006934088;5825.155352473952;5827.3007239131575;5651.8304450866535;5654.575906807088;5663.433656634304;5680.6591604503865;5704.686242256716;5524.281843360337;5657.464084946908;5661.830145095653;5665.603407761582;5710.086386178192;5342;5556.277683901067;5585.720713964204;5595;5604.3835178131185;5582.190582365615;5737.91393129095;5742.454466825645;5745.626534275259;5773.422657734361;5530.230326295547;5545.916811247916;5567.526760225426;5571.164325351229;5573.136163894603 05:43:32 INFO - PROCESS | 16727 | |5;yui.html;643.5270076493779;721.7221369772636;752.8682480565901;764.1250767870791;764.9541027538348;12074.275543467398;12243;12269.386530673464;12299.815502767466;12420.130590858644;11719.824202636946;11748.765024699502;11749.53001879926;11790.764184716301;11810.704732381695;622.5797586629008;711.5659447736876;771.8494893495756;784.705735349244;786.6420778545777;780.1457404142454;784.1178673991759;787.0751866556801;790.3953475591177;791.0783936713722;821.1993306526149;826.7271800305884;827.8054657155564;829.4732844643635;829.6598394658191;821.1542111625035;823.2220551578761;824.2540500846743;824.6660102658433;825.2613910550054;599.8920194365013;603.3242768099713;604.0365616841132;604.9879002419927;607.76601008612;12558.81161782574;12573.559925402658;12577.05672074589;12667.746645067047;12683.302418366986;11897.940510297392;12219.694507637292;12230.14388992771;12317.56888508907;12507.49970001199;10940.45297735118;10952.835707464394;11098.611548595842;11167.329960202414;11413.771724565462;4250.851220207309;4257.318828987378;4274.786260686984;4311.8706438806885;4369.650427965787;48202;48279.517204827855;49235;49317.506824931654;49350.75324623426;9255.213306868991;9482.525873706287;9579.712608621752;9637.084476974676;9699.127078562964;15703.371865125495;15736.134512601917;15746.921265393828;15781.210939452982;17921.910390447963;7005.614691191931;7007.684654190573;7010.684519196649;7024.578525288397;7081.398081163159;3674.9632503675157;3755.6619904208205;3824.4263360496147;3829.4255861620422;3866.7486613370043;2872.3967966726805;2925.956110658342;2939.5737618045264;2940;2945.5434407666844;507.1910303066603;507.81210951947276;512.2086376548242;520.4795204795205;521.4290352064484;571.6427232979388;590.10598942602;600.5825950964038;608.5131894484394;609.7347653770624;7391.963040184764;7395;7483.2516748325825;7573.545587264782;7747.690092396241;454.18927214921865;481.8000529780172;542.6852425593147;544.7657507271911;545.370097537345;3362.529245905575;3399.218179818606;3402.625711171769;3435.2442462658173;3542.769719968194;53897.46102539003;54403;54604.45395546073;54702;55011.72494137504;47562;47935.28097078547;48133.5186648129;48260.517394826304;48425.757871210415;42909.141817164105;43211.35182972258;43403.34894976578;43406.348904766455;44117.77941110274;6733.797986060426;6798.354156355138;6809.659517024228;6868.038474613458;6886.69009894566;28607.9987200447;28794.42411151807;29252.268693282836;29564.556531652473;29749.10752677423;35587.82206088953;36922;38977.41533877051;39097.804510977265;39555.20889582135;9192;9212.723618291462;9308.674196403093;9368.906310936803;9452.527373631428;9185.357025008185;9799.755006124904;9864.950675246579;9967.40195588267;9995.300328977193;8962.32782541299;9177.541122943692;9218.815623687622;9232.169104780602;9297.72106836796;8923.268250217634;9016.639334426813;9182.403143795633;9351.5791789371;9527.523623818919;9196.402233854778;9220.712025631427;9456.196223321094;9473.763155921157;9495.19290860257;7854.842903141791;7973.720919768012;7993.520388776692;8046.798830029296;8198.631061602124;8016.496074729067;8037.156098609562;8089.2315230053055;8124.309433698202;8410.243078122998 05:43:32 INFO - PROCESS | 16727 | __end_tp_report 05:43:32 INFO - PROCESS | 16727 | __start_cc_report 05:43:32 INFO - PROCESS | 16727 | _x_x_mozilla_cycle_collect,361 05:43:32 INFO - PROCESS | 16727 | __end_cc_report 05:43:32 INFO - PROCESS | 16727 | __startTimestamp1461588212334__endTimestamp 05:43:32 INFO - PROCESS | 16727 | 05:43:32 INFO - PROCESS | 16727 | ------- Summary: start ------- 05:43:32 INFO - PROCESS | 16727 | Number of tests: 6 05:43:32 INFO - PROCESS | 16727 | 05:43:32 INFO - PROCESS | 16727 | [#0] dojo.html Cycles:165 Average:4747.69 Median:4886.88 stddev:602.52 (12.3%) stddev-sans-first:581.14 05:43:32 INFO - PROCESS | 16727 | Values: 2636.0 2675.4 2701.0 2713.1 2713.5 4822.0 4824.0 4826.2 4836.5 4842.2 4672.5 4808.9 4813.4 4878.2 4886.9 4417.5 4442.0 4499.5 4507.1 4547.2 603.6 4301.6 4443.6 4458.5 4476.6 4415.6 4420.2 4434.3 4442.2 4467.4 4367.8 4503.5 4521.1 4523.9 4539.2 4366.0 4378.6 4409.3 4433.6 4445.0 4680.0 4685.5 4722.4 4752.5 4772.6 5048.5 5143.6 5179.5 5203.8 5260.8 5148.4 5150.0 5152.7 5161.3 5221.5 4812.2 4815.0 4829.3 4846.0 4873.4 5269.8 5330.1 5349.1 5400.9 5408.2 5084.6 5093.3 5100.8 5113.4 5160.0 4962.3 5180.8 5184.1 5187.0 5202.2 5060.2 5081.5 5102.8 5154.6 5168.3 4999.3 5151.6 5189.6 5190.0 5241.9 4255.8 4304.1 4320.2 4325.4 4367.5 3736.1 3780.7 3796.7 3818.5 3822.9 4426.0 4428.3 4432.6 4444.6 4472.4 5088.5 5114.8 5127.8 5130.5 5160.9 4428.4 4448.8 4463.5 4486.3 4506.7 4618.2 4621.0 4621.2 4627.2 4651.1 4777.7 4846.2 4847.6 4877.1 4938.7 5178.2 5185.5 5197.1 5205.3 5234.4 4843.8 4852.1 4852.7 4857.1 4898.1 5014.5 5065.4 5108.4 5181.3 5186.9 5177.7 5207.3 5209.7 5213.7 5214.1 5046.1 5047.5 5059.7 5063.3 5072.8 4903.6 4945.5 5050.7 5111.8 5121.8 4887.1 4889.7 4906.6 4941.7 4982.9 5089.8 5092.5 5114.4 5115.1 5169.6 4866.1 4974.6 5003.7 5009.9 5064.9 05:43:32 INFO - PROCESS | 16727 | 05:43:32 INFO - PROCESS | 16727 | [#1] ext.html Cycles:180 Average:41661.67 Median:35307.97 stddev:73718.09 (208.8%) stddev-sans-first:73860.35 05:43:32 INFO - PROCESS | 16727 | Values: 577.4 602.2 610.6 620.6 637.8 33981.7 35048.8 35070.8 35336.8 35386.3 35210.1 35870.1 36163.3 36181.6 36198.0 7496.4 7642.8 7648.2 7657.1 7663.3 7402.0 7649.7 7661.1 7676.7 7689.5 7654.8 7667.1 7680.5 7684.1 7708.5 7598.5 7614.5 7619.2 7652.3 7656.0 7527.0 7615.9 7622.5 7630.6 7650.7 29068.3 35279.1 35652.3 35727.5 35843.6 2815.6 3051.7 3137.8 3392.9 3612.2 24896.9 25153.5 25376.9 25519.0 25536.1 3418.9 3485.0 3496.8 3568.9 3589.8 203091.0 204135.0 204272.0 204592.0 204673.0 32075.2 33074.3 48367.8 49165.5 49716.3 31567.0 31604.7 31734.5 31745.0 31869.0 11755.8 11821.2 11833.8 11838.6 11854.7 9747.3 9764.0 9827.2 9887.3 9932.2 7889.5 7910.2 7952.4 8002.1 8023.2 3185.6 3189.6 3218.7 3221.2 3226.4 906.5 919.5 949.3 982.2 1028.1 25844.6 27108.0 27271.2 27345.3 27477.3 956.3 997.3 1002.3 1012.0 1054.9 14413.9 14577.6 14715.9 14853.3 14935.4 331705.0 337666.0 340558.0 341655.0 344960.0 48351.8 48713.0 48862.8 49306.8 49338.5 1157.7 1193.8 1213.5 1214.9 1220.8 25790.1 26547.3 26907.2 27485.9 27607.3 42258.8 42873.0 43048.0 43157.4 43321.0 254959.0 255262.0 257245.0 312651.0 314602.0 24865.9 25078.5 25297.7 25373.0 25414.9 40009.2 40328.8 40687.6 41079.2 41340.2 35091.8 35659.5 36278.0 36346.8 36621.0 35699.3 36200.5 36250.3 36407.5 36521.5 35251.8 35619.5 36054.6 37394.4 37548.8 27263.0 31746.4 33393.8 33794.9 34110.7 24033.3 24152.8 24351.5 24367.5 24632.0 05:43:32 INFO - PROCESS | 16727 | 05:43:32 INFO - PROCESS | 16727 | [#2] jquery.html Cycles:180 Average:24888.02 Median:47987.90 stddev:66562.52 (138.7%) stddev-sans-first:66723.80 05:43:32 INFO - PROCESS | 16727 | Values: 378.1 379.8 382.2 382.7 394.9 15763.3 16291.6 17074.4 17131.8 17145.3 16798.2 17481.1 17632.9 17750.9 17856.4 5745.7 5907.4 5916.0 5947.5 5970.7 3980.5 6706.8 7077.3 7122.1 7129.9 6857.0 6957.7 7066.7 7087.9 7120.5 6728.7 7028.5 7075.8 7094.4 7105.7 6812.6 6862.2 6924.6 6930.3 6934.5 20702.4 21177.2 21662.7 22005.9 22741.5 1992.9 1999.2 2180.2 2184.8 2743.4 13606.3 13783.2 14063.7 14089.5 15117.2 1855.1 1888.0 1944.7 1955.7 1984.6 60620.0 62584.0 64925.4 78317.0 82330.6 14668.9 16517.7 16723.0 16723.4 16859.2 29792.4 29923.7 29951.9 30149.8 30248.8 8483.8 8897.5 9029.5 9084.3 9099.8 7224.9 7244.2 7265.7 7356.0 7413.9 3592.6 3968.1 8331.4 8463.4 8504.3 1878.5 1910.2 1917.4 1923.6 1934.9 842.7 869.3 894.6 922.6 942.6 15381.2 15555.6 15710.1 15838.8 16010.6 877.8 881.4 887.5 928.9 938.4 9173.3 9314.3 9466.7 9682.6 9686.8 399807.0 403028.0 405089.0 414173.0 415321.0 44189.6 44362.8 45439.5 46554.8 47544.3 860.7 863.9 875.0 879.0 891.0 14808.9 14812.3 14912.3 14980.7 14999.5 33684.5 34725.7 35192.5 36401.8 36540.9 48431.5 50362.2 50570.0 50862.5 50932.7 7606.7 7726.3 7731.8 7739.3 7820.5 10448.6 11268.2 11276.8 11395.4 11652.8 9439.4 9684.7 9713.1 9969.8 10131.4 9476.4 9759.5 9999.2 10124.5 10164.7 9839.2 10035.3 10107.4 10274.4 10360.7 7292.7 7611.9 7825.4 7851.0 7886.9 9358.4 9562.2 9600.3 9630.4 10102.9 05:43:32 INFO - PROCESS | 16727 | 05:43:32 INFO - PROCESS | 16727 | [#3] mootools.html Cycles:180 Average:5214.43 Median:5166.03 stddev:2897.44 (56.1%) stddev-sans-first:2891.66 05:43:32 INFO - PROCESS | 16727 | Values: 1437.3 1446.6 1530.6 1690.6 1729.7 7022.5 7590.8 7681.6 7979.5 7998.9 7730.7 7810.8 7915.6 7933.8 7950.6 2270.6 2337.3 2337.5 2337.5 2339.8 2278.6 2298.9 2329.7 2341.1 2342.5 2311.4 2339.7 2346.1 2347.4 2348.9 2242.4 2246.0 2255.5 2256.6 2283.0 2230.3 2249.1 2258.6 2266.9 2272.0 7976.4 8017.6 8021.7 8059.3 8076.5 4780.3 4952.4 4975.0 4978.5 4996.8 2947.8 2954.1 3056.1 3057.5 3070.0 969.6 974.6 979.4 998.3 1017.8 10526.6 10730.3 10770.2 10786.4 10833.2 4399.1 4477.4 4655.7 4664.4 4691.1 9256.1 9258.8 9270.5 9275.7 9323.4 4899.8 4905.9 4906.6 4920.8 4936.5 3781.1 4313.4 4445.7 4447.0 4452.0 3633.5 3663.6 3716.6 3768.1 3779.5 1217.4 1234.7 1240.8 1241.6 1247.7 772.2 780.3 783.2 783.5 798.0 4944.9 5164.0 5274.9 5382.4 5532.2 828.5 867.7 883.2 900.8 906.2 3522.7 3566.9 3655.7 3698.3 3750.8 9505.2 9785.1 9865.5 9911.0 9913.2 9729.8 9736.1 9736.1 9797.8 9809.5 7395.1 7578.4 7595.7 7611.5 7641.4 4880.1 4966.4 5130.2 5168.1 5317.8 9044.2 9059.8 9135.8 9171.3 9181.3 9101.1 9174.9 9327.2 9336.1 9377.7 6130.4 6130.4 6583.2 6880.0 6886.3 7438.6 7463.9 7472.2 7474.6 7556.1 6605.4 6781.9 6809.3 6871.2 6884.9 6610.8 6648.4 6725.9 6753.2 6849.7 5991.5 6215.5 6250.7 6276.4 6347.8 4125.7 4155.9 4170.3 4230.6 4236.2 4314.1 4325.0 4355.9 4390.7 4426.9 05:43:32 INFO - PROCESS | 16727 | 05:43:32 INFO - PROCESS | 16727 | [#4] prototype.html Cycles:180 Average:4653.11 Median:5351.18 stddev:1368.74 (25.6%) stddev-sans-first:1333.33 05:43:32 INFO - PROCESS | 16727 | Values: 317.6 319.3 322.3 325.0 326.7 5327.4 5408.2 5420.5 5420.6 5440.4 5342.8 5344.4 5347.2 5355.2 5362.7 3930.5 4031.8 4125.9 4139.5 4166.1 4152.9 4166.0 4177.7 4180.8 4183.7 4151.9 4153.5 4159.3 4159.8 4160.3 4045.4 4148.7 4167.3 4170.0 4178.6 3668.5 3680.3 3681.6 3682.6 3690.0 5109.3 5131.7 5139.2 5153.1 5163.1 4412.0 4694.7 4797.2 4818.3 4818.5 5533.8 5536.2 5640.3 5644.0 5648.6 3919.9 3920.7 3926.2 3930.7 3942.7 5805.2 5845.8 5903.2 5965.7 5982.1 4001.1 4023.4 4033.6 4035.6 4044.3 4075.6 4089.6 4089.6 4091.2 4095.9 4601.7 4703.2 4707.6 4709.2 4713.9 5644.2 5671.5 5674.3 5697.7 5701.7 1382.5 1403.7 1420.4 1422.9 1424.1 858.0 917.8 943.3 960.9 963.7 4818.0 4901.4 4914.7 4917.1 4931.0 5731.3 5762.6 5789.0 5800.2 5810.7 4759.2 4859.3 4882.4 4897.7 4914.5 3097.6 3102.2 3117.3 3124.4 3136.3 5380.2 5381.4 5388.5 5397.8 5414.8 5773.9 5866.9 5960.8 5965.8 5979.4 5355.4 5399.9 5405.2 5406.9 5413.4 5552.8 5759.7 5776.2 5794.0 5820.7 5684.1 5687.3 5696.5 5705.1 5709.7 5323.4 5378.7 5404.8 5443.6 5454.1 3803.9 3993.4 4009.3 4035.1 4062.8 5780.7 5812.5 5817.3 5825.2 5827.3 5651.8 5654.6 5663.4 5680.7 5704.7 5524.3 5657.5 5661.8 5665.6 5710.1 5342.0 5556.3 5585.7 5595.0 5604.4 5582.2 5737.9 5742.5 5745.6 5773.4 5530.2 5545.9 5567.5 5571.2 5573.1 05:43:32 INFO - PROCESS | 16727 | 05:43:32 INFO - PROCESS | 16727 | [#5] yui.html Cycles:180 Average:12574.59 Median:580.87 stddev:14966.41 (2576.5%) stddev-sans-first:14981.58 05:43:32 INFO - PROCESS | 16727 | Values: 643.5 721.7 752.9 764.1 765.0 12074.3 12243.0 12269.4 12299.8 12420.1 11719.8 11748.8 11749.5 11790.8 11810.7 622.6 711.6 771.8 784.7 786.6 780.1 784.1 787.1 790.4 791.1 821.2 826.7 827.8 829.5 829.7 821.2 823.2 824.3 824.7 825.3 599.9 603.3 604.0 605.0 607.8 12558.8 12573.6 12577.1 12667.7 12683.3 11897.9 12219.7 12230.1 12317.6 12507.5 10940.5 10952.8 11098.6 11167.3 11413.8 4250.9 4257.3 4274.8 4311.9 4369.7 48202.0 48279.5 49235.0 49317.5 49350.8 9255.2 9482.5 9579.7 9637.1 9699.1 15703.4 15736.1 15746.9 15781.2 17921.9 7005.6 7007.7 7010.7 7024.6 7081.4 3675.0 3755.7 3824.4 3829.4 3866.7 2872.4 2926.0 2939.6 2940.0 2945.5 507.2 507.8 512.2 520.5 521.4 571.6 590.1 600.6 608.5 609.7 7392.0 7395.0 7483.3 7573.5 7747.7 454.2 481.8 542.7 544.8 545.4 3362.5 3399.2 3402.6 3435.2 3542.8 53897.5 54403.0 54604.5 54702.0 55011.7 47562.0 47935.3 48133.5 48260.5 48425.8 42909.1 43211.4 43403.3 43406.3 44117.8 6733.8 6798.4 6809.7 6868.0 6886.7 28608.0 28794.4 29252.3 29564.6 29749.1 35587.8 36922.0 38977.4 39097.8 39555.2 9192.0 9212.7 9308.7 9368.9 9452.5 9185.4 9799.8 9865.0 9967.4 9995.3 8962.3 9177.5 9218.8 9232.2 9297.7 8923.3 9016.6 9182.4 9351.6 9527.5 9196.4 9220.7 9456.2 9473.8 9495.2 7854.8 7973.7 7993.5 8046.8 8198.6 8016.5 8037.2 8089.2 8124.3 8410.2 05:43:32 INFO - PROCESS | 16727 | -------- Summary: end -------- 05:43:32 INFO - PROCESS | 16727 | 05:43:33 INFO - TEST-INFO | 16727: exit 0 05:43:33 INFO - TEST-OK | dromaeo_css | took 1114982ms 05:43:33 INFO - TEST-START | kraken 05:43:33 INFO - operating with platform_type : linux_ 05:43:33 INFO - Initialising browser for kraken test... 05:43:33 INFO - TEST-INFO | started process 16960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoRCgem/profile http://localhost:41675/getInfo.html) 05:43:37 INFO - PROCESS | 16960 | 05:43:37 INFO - PROCESS | 16960 | (process:17028): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:43:37 INFO - PROCESS | 16960 | __metrics Screen width/height:1600/1200 05:43:37 INFO - PROCESS | 16960 | colorDepth:24 05:43:37 INFO - PROCESS | 16960 | Browser inner width/height: 1024/697 05:43:37 INFO - PROCESS | 16960 | __metrics 05:43:38 ERROR - PROCESS | 16960 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:43:39 INFO - TEST-INFO | 16960: exit 0 05:43:39 INFO - Browser initialized. 05:43:39 INFO - Running cycle 1/1 for kraken test... 05:43:39 INFO - TEST-INFO | started process 17079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoRCgem/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:41 INFO - PROCESS | 17079 | 05:43:41 INFO - PROCESS | 17079 | (process:17138): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:43:51 INFO - PROCESS | 17079 | RSS: Main: 164724736 05:43:51 INFO - PROCESS | 17079 | 05:43:53 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41675/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:54 INFO - PROCESS | 17079 | RSS: Main: 169533440 05:43:54 INFO - PROCESS | 17079 | 05:43:57 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41675/tests/kraken/driver.html?testName=audio-dft) 05:43:58 INFO - PROCESS | 17079 | RSS: Main: 173203456 05:43:58 INFO - PROCESS | 17079 | 05:44:01 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41675/tests/kraken/driver.html?testName=audio-fft) 05:44:01 INFO - PROCESS | 17079 | RSS: Main: 165388288 05:44:01 INFO - PROCESS | 17079 | 05:44:04 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41675/tests/kraken/driver.html?testName=audio-oscillator) 05:44:04 INFO - PROCESS | 17079 | RSS: Main: 164945920 05:44:04 INFO - PROCESS | 17079 | 05:44:07 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:07 INFO - PROCESS | 17079 | RSS: Main: 165711872 05:44:07 INFO - PROCESS | 17079 | 05:44:10 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41675/tests/kraken/driver.html?testName=imaging-darkroom) 05:44:11 INFO - PROCESS | 17079 | RSS: Main: 165453824 05:44:11 INFO - PROCESS | 17079 | 05:44:14 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41675/tests/kraken/driver.html?testName=imaging-desaturate) 05:44:15 INFO - PROCESS | 17079 | RSS: Main: 165285888 05:44:15 INFO - PROCESS | 17079 | 05:44:18 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41675/tests/kraken/driver.html?testName=json-parse-financial) 05:44:19 INFO - PROCESS | 17079 | RSS: Main: 166076416 05:44:19 INFO - PROCESS | 17079 | 05:44:20 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:21 INFO - PROCESS | 17079 | RSS: Main: 166391808 05:44:21 INFO - PROCESS | 17079 | 05:44:23 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41675/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:23 INFO - PROCESS | 17079 | RSS: Main: 166297600 05:44:23 INFO - PROCESS | 17079 | 05:44:26 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:26 INFO - PROCESS | 17079 | RSS: Main: 166526976 05:44:26 INFO - PROCESS | 17079 | 05:44:29 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:30 INFO - PROCESS | 17079 | RSS: Main: 166780928 05:44:30 INFO - PROCESS | 17079 | 05:44:33 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:33 INFO - PROCESS | 17079 | RSS: Main: 166920192 05:44:33 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | Cycle 1(1): loaded http://localhost:41675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41675/tests/kraken/driver.html?testName=ai-astar) 05:44:35 INFO - PROCESS | 17079 | RSS: Main: 168366080 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | __start_tp_report 05:44:35 INFO - PROCESS | 17079 | _x_x_mozilla_page_load 05:44:35 INFO - PROCESS | 17079 | _x_x_mozilla_page_load_details 05:44:35 INFO - PROCESS | 17079 | |i|pagename|runs| 05:44:35 INFO - PROCESS | 17079 | |0;ai-astar;114;107;114;114;114;127;114;116;112;112 05:44:35 INFO - PROCESS | 17079 | |1;audio-beat-detection;163;133;160;185;137;160;153;133;194;138 05:44:35 INFO - PROCESS | 17079 | |2;audio-dft;162;162;164;177;163;162;163;163;167;162 05:44:35 INFO - PROCESS | 17079 | |3;audio-fft;76;74;77;149;75;76;76;76;154;75 05:44:35 INFO - PROCESS | 17079 | |4;audio-oscillator;95;95;143;95;94;93;152;94;94;145 05:44:35 INFO - PROCESS | 17079 | |5;imaging-gaussian-blur;118;118;117;118;118;130;121;125;122;118 05:44:35 INFO - PROCESS | 17079 | |6;imaging-darkroom;149;147;147;149;148;148;148;148;147;148 05:44:35 INFO - PROCESS | 17079 | |7;imaging-desaturate;97;96;95;97;95;96;95;95;95;95 05:44:35 INFO - PROCESS | 17079 | |8;json-parse-financial;65;65;65;66;65;67;66;65;64;66 05:44:35 INFO - PROCESS | 17079 | |9;json-stringify-tinderbox;64;66;65;65;64;65;65;64;65;65 05:44:35 INFO - PROCESS | 17079 | |10;stanford-crypto-aes;79;80;81;79;81;80;83;81;117;80 05:44:35 INFO - PROCESS | 17079 | |11;stanford-crypto-ccm;146;135;148;138;139;135;135;148;135;135 05:44:35 INFO - PROCESS | 17079 | |12;stanford-crypto-pbkdf2;188;180;183;177;179;179;179;175;176;180 05:44:35 INFO - PROCESS | 17079 | |13;stanford-crypto-sha256-iterative;73;75;75;72;74;78;74;75;72;78 05:44:35 INFO - PROCESS | 17079 | __end_tp_report 05:44:35 INFO - PROCESS | 17079 | __start_cc_report 05:44:35 INFO - PROCESS | 17079 | _x_x_mozilla_cycle_collect,919 05:44:35 INFO - PROCESS | 17079 | __end_cc_report 05:44:35 INFO - PROCESS | 17079 | __startTimestamp1461588275977__endTimestamp 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | ------- Summary: start ------- 05:44:35 INFO - PROCESS | 17079 | Number of tests: 14 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:5.04 (4.4%) stddev-sans-first:5.34 05:44:35 INFO - PROCESS | 17079 | Values: 114.0 107.0 114.0 114.0 114.0 127.0 114.0 116.0 112.0 112.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#1] audio-beat-detection Cycles:10 Average:155.60 Median:160.00 stddev:21.39 (13.4%) stddev-sans-first:22.52 05:44:35 INFO - PROCESS | 17079 | Values: 163.0 133.0 160.0 185.0 137.0 160.0 153.0 133.0 194.0 138.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#2] audio-dft Cycles:10 Average:164.50 Median:163.00 stddev:4.65 (2.9%) stddev-sans-first:4.84 05:44:35 INFO - PROCESS | 17079 | Values: 162.0 162.0 164.0 177.0 163.0 162.0 163.0 163.0 167.0 162.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#3] audio-fft Cycles:10 Average:90.80 Median:76.00 stddev:32.02 (42.1%) stddev-sans-first:33.52 05:44:35 INFO - PROCESS | 17079 | Values: 76.0 74.0 77.0 149.0 75.0 76.0 76.0 76.0 154.0 75.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:94.00 stddev:25.41 (27.0%) stddev-sans-first:26.36 05:44:35 INFO - PROCESS | 17079 | Values: 95.0 95.0 143.0 95.0 94.0 93.0 152.0 94.0 94.0 145.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#5] imaging-gaussian-blur Cycles:10 Average:120.50 Median:119.50 stddev:4.17 (3.5%) stddev-sans-first:4.32 05:44:35 INFO - PROCESS | 17079 | Values: 118.0 118.0 117.0 118.0 118.0 130.0 121.0 125.0 122.0 118.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 05:44:35 INFO - PROCESS | 17079 | Values: 149.0 147.0 147.0 149.0 148.0 148.0 148.0 148.0 147.0 148.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.73 05:44:35 INFO - PROCESS | 17079 | Values: 97.0 96.0 95.0 97.0 95.0 96.0 95.0 95.0 95.0 95.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 05:44:35 INFO - PROCESS | 17079 | Values: 65.0 65.0 65.0 66.0 65.0 67.0 66.0 65.0 64.0 66.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 05:44:35 INFO - PROCESS | 17079 | Values: 64.0 66.0 65.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:80.50 stddev:11.62 (14.4%) stddev-sans-first:12.18 05:44:35 INFO - PROCESS | 17079 | Values: 79.0 80.0 81.0 79.0 81.0 80.0 83.0 81.0 117.0 80.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:138.50 stddev:5.68 (4.1%) stddev-sans-first:5.50 05:44:35 INFO - PROCESS | 17079 | Values: 146.0 135.0 148.0 138.0 139.0 135.0 135.0 148.0 135.0 135.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:179.50 stddev:3.72 (2.1%) stddev-sans-first:2.40 05:44:35 INFO - PROCESS | 17079 | Values: 188.0 180.0 183.0 177.0 179.0 179.0 179.0 175.0 176.0 180.0 05:44:35 INFO - PROCESS | 17079 | 05:44:35 INFO - PROCESS | 17079 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:75.00 stddev:2.12 (2.8%) stddev-sans-first:2.17 05:44:35 INFO - PROCESS | 17079 | Values: 73.0 75.0 75.0 72.0 74.0 78.0 74.0 75.0 72.0 78.0 05:44:35 INFO - PROCESS | 17079 | -------- Summary: end -------- 05:44:35 INFO - PROCESS | 17079 | 05:44:36 INFO - TEST-INFO | 17079: exit 0 05:44:36 INFO - TEST-OK | kraken | took 63863ms 05:44:36 INFO - SUITE-END | took 1178s 05:44:37 INFO - Completed test suite (00:19:39) 05:44:37 INFO - javascript benchmark 05:44:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.0, 2675.3712877473795, 2701.0, 2713.131797824697, 2713.5386984212682, 4822.0, 4823.999999999995, 4826.227803551433, 4836.540528649773, 4842.201036828923, 4672.509386514418, 4808.927866082012, 4813.350197723306, 4878.170710979133, 4886.8778280543, 4417.51407345191, 4442.0, 4499.527549607294, 4507.053518761064, 4547.204239258117, 603.5635157381392, 4301.612854843063, 4443.60007599316, 4458.531854155316, 4476.597106260436, 4415.580519850609, 4420.20436321462, 4434.290513517822, 4442.244818380883, 4467.419235499365, 4367.781610919441, 4503.527129651405, 4521.050579378334, 4523.886902827423, 4539.205639013159, 4365.978170109161, 4378.562143785628, 4409.250427427345, 4433.556644335541, 4445.022095139064, 4679.976600117012, 4685.5314468553215, 4722.409698787652, 4752.500987396343, 4772.594329481998, 5048.469910659364, 5143.588512918957, 5179.507946745053, 5203.8178663746585, 5260.842174734764, 5148.433672296044, 5149.9742501287255, 5152.665076770036, 5161.303224064741, 5221.451747566489, 4812.181929072031, 4814.975925120352, 4829.251466022772, 4846.000784014078, 4873.366462359871, 5269.762860671279, 5330.093884039723, 5349.063913815066, 5400.945990540123, 5408.188771684278, 5084.618653600995, 5093.286939828427, 5100.846974590768, 5113.386393632788, 5160.019596276696, 4962.255661650709, 5180.81867134656, 5184.14461613837, 5186.974065129651, 5202.167653175474, 5060.240963855377, 5081.5426611605135, 5102.770375333119, 5154.639175257771, 5168.302279192336, 4999.325091112726, 5151.639385243072, 5189.584833213334, 5189.974050129726, 5241.9213711794355, 4255.787210639455, 4304.053108316165, 4320.157569273962, 4325.3728209409455, 4367.47590289161, 3736.1220113273357, 3780.678642315379, 3796.6583007529457, 3818.5417749870194, 3822.9044273893373, 4425.977870110629, 4428.2914733642465, 4432.645388368923, 4444.622207112432, 4472.39622650938, 5088.465711100355, 5114.846554603368, 5127.769250383742, 5130.461301563282, 5160.870978225575, 4428.446444194476, 4448.755318457451, 4463.509014008457, 4486.2597671383855, 4506.7070640408265, 4618.214903466419, 4620.953790462119, 4621.168189725814, 4627.236505976476, 4651.093036857848, 4777.665563410528, 4846.176150054429, 4847.636427267969, 4877.073356062337, 4938.728369939688, 5178.249153872592, 5185.455527169744, 5197.0905091608065, 5205.297284866495, 5234.371875374979, 4843.806247750051, 4852.053849499313, 4852.684575502581, 4857.077155340474, 4898.093852637274, 5014.473480284663, 5065.39215294167, 5108.361454818148, 5181.3005244291535, 5186.948130518646, 5177.689338639693, 5207.3490813648295, 5209.7395130244095, 5213.713245771367, 5214.113600687816, 5046.116929537389, 5047.545720885138, 5059.747012649279, 5063.291139240583, 5072.797088116582, 4903.60771138301, 4945.530174633404, 5050.72221027847, 5111.79552817898, 5121.820736274212, 4887.144749668722, 4889.657723959289, 4906.63200259989, 4941.678790878582, 4982.925256121233, 5089.821856235014, 5092.516210959953, 5114.411842638145, 5115.079285728456, 5169.586433085269, 4866.148424025852, 4974.602031837517, 5003.724795136302, 5009.899802003866, 5064.949350506447], "value": 4710.761617693942, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.356247783721, 602.2141105856857, 610.6244659534385, 620.5687047501985, 637.751277001969, 33981.66018339819, 35048.82475587619, 35070.82464587673, 35336.82331588342, 35386.292274154504, 35210.119747006334, 35870.103247418825, 36163.2767344653, 36181.63818361815, 36198.0, 7496.437767167471, 7642.847143057135, 7648.158702542716, 7657.119431265392, 7663.27198916102, 7402.0, 7649.6940122395035, 7661.118971318314, 7676.692932282702, 7689.50018248812, 7654.808629784272, 7667.118281397627, 7680.539167649931, 7684.07791065073, 7708.498947568418, 7598.544087354749, 7614.505057171266, 7619.238076192391, 7652.273034061783, 7655.961720191392, 7526.962365188194, 7615.885761713524, 7622.504537205064, 7630.618469076524, 7650.655720492591, 29068.27329316763, 35279.1180220494, 35652.28695426103, 35727.4640880387, 35843.64156358429, 2815.5635876439183, 3051.6948305169303, 3137.7803553751246, 3392.932141357184, 3612.24142929985, 24896.875515622487, 25153.496930061297, 25376.873115634302, 25519.0, 25536.106236281827, 3418.9145271368166, 3484.9633056796515, 3496.8251587420527, 3568.9107772305642, 3589.7846129232066, 203091.0, 204135.0, 204272.0, 204591.99999999852, 204673.0, 32075.198120047186, 33074.3385132296, 48367.75816120967, 49165.50834491681, 49716.254256186185, 31567.0, 31604.683953160173, 31734.523982140287, 31745.04764857058, 31869.0, 11755.823662645067, 11821.172517923835, 11833.822492662617, 11838.644840654793, 11854.703632409086, 9747.317687761788, 9764.0, 9827.213822894151, 9887.30788844774, 9932.155766759763, 7889.487183333065, 7910.16943220965, 7952.403569732293, 8002.119766825645, 8023.197680232047, 3185.649578546358, 3189.649138594753, 3218.6935656061078, 3221.1785994571233, 3226.3708576827294, 906.5467266366817, 919.4529255093208, 949.3212353167519, 982.2485798364257, 1028.1466382902322, 25844.612330815053, 27108.0, 27271.181864544094, 27345.31636709098, 27477.31306717348, 956.32101208143, 997.3344514660389, 1002.308407199045, 1011.9696409107592, 1054.9103326217205, 14413.855861441461, 14577.641137530105, 14715.92642036783, 14853.331600078023, 14935.402583896739, 331705.0, 337666.0, 340558.0, 341655.0, 344960.0, 48351.75824120857, 48713.0, 48862.75568622134, 49306.75346623316, 49338.50661493411, 1157.6642773595563, 1193.803022501295, 1213.4600102954278, 1214.9028077753758, 1220.7741567809983, 25790.09734659278, 26547.33631659224, 26907.192784216506, 27485.86257068702, 27607.309817253925, 42258.78870605627, 42873.0, 43048.0, 43157.3526397098, 43321.0, 254959.0, 255262.0, 257245.0, 312651.0, 314602.0, 24865.87567062153, 25078.49843003166, 25297.74702252954, 25373.0, 25414.872925635995, 40009.1998160041, 40328.79835600803, 40687.593124069565, 41079.17841643091, 41340.1731965353, 35091.82454087713, 35659.46510802288, 36278.0, 36346.8182659085, 36621.0, 35699.28601427905, 36200.456993144595, 36250.27499450049, 36407.45388819117, 36521.45217821788, 35251.82374088113, 35619.46570801388, 36054.63945360513, 37394.43908341323, 37548.812255938545, 27263.0, 31746.365072697954, 33393.83303083469, 33794.94460664736, 34110.65889341174, 24033.27900162998, 24152.75847241505, 24351.51296974086, 24367.51264974726, 24632.0], "value": 15815.733290566233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.0510917596833, 379.7778299694679, 382.18213024128363, 382.6766382406867, 394.88745707473373, 15763.290651920663, 16291.592710182236, 17074.402395916146, 17131.828681713178, 17145.314187432505, 16798.244079016444, 17481.125943702827, 17632.8538644988, 17750.911245443756, 17856.375026874062, 5745.741441635126, 5907.350191478934, 5915.9704201478935, 5947.464728174464, 5970.701464926758, 3980.4825372701653, 6706.798796036127, 7077.327653872874, 7122.1453425589, 7129.928700713004, 6856.965715171417, 6957.721691132374, 7066.681999310018, 7087.89368159478, 7120.50156489046, 6728.663566821689, 7028.54314469563, 7075.787726368191, 7094.432445404355, 7105.7157713691395, 6812.62530560819, 6862.210845752752, 6924.58452492852, 6930.272321406281, 6934.514583979124, 20702.447316451176, 21177.15291388358, 21662.675059874113, 22005.889970550044, 22741.545169096524, 1992.8505362097756, 1999.240288690303, 2180.226019762993, 2184.847060705751, 2743.3553115017953, 13606.31968401576, 13783.173009619455, 14063.718725625533, 14089.506867259699, 15117.244137793066, 1855.1280897977929, 1887.962240755191, 1944.7277381166648, 1955.687090065597, 1984.5534754680082, 60620.0, 62584.0, 64925.35074649288, 78317.0, 82330.58834705788, 14668.912401353533, 16517.669646607, 16723.0, 16723.411275928767, 16859.157042147843, 29792.404151917275, 29923.70076299253, 29951.850240748656, 30149.849250754043, 30248.84875575608, 8483.83032339362, 8897.466152030769, 9029.458232506071, 9084.273258139334, 9099.81800363989, 7224.927750722531, 7244.166920804069, 7265.745698900513, 7355.963220183972, 7413.851722965511, 3592.6227746086806, 3968.146848427602, 8331.416800824005, 8463.449875758057, 8504.31965442763, 1878.549148204421, 1910.178623192013, 1917.3864363403857, 1923.5768131011155, 1934.9129289182022, 842.6966292134827, 869.2698133567707, 894.561664784251, 922.6078916460477, 942.5569982108398, 15381.154036527874, 15555.611109722347, 15710.135942523042, 15838.76241856373, 16010.599735006717, 877.7937184761576, 881.3830318776882, 887.4896934262824, 928.9256859451227, 938.4463166731662, 9173.266138708887, 9314.301427392837, 9466.715998520056, 9682.612695492102, 9686.78915135608, 399807.0, 403028.0, 405089.0, 414173.0, 415321.0, 44189.558104419186, 44362.778186108866, 45439.545604543535, 46554.767226163654, 47544.286835697494, 860.6858496648678, 863.9395242332977, 874.9518776467355, 878.9604467798964, 891.0065277215987, 14808.92754492523, 14812.333444994785, 14912.328945197276, 14980.700385992437, 14999.475018374305, 33684.49473257854, 34725.652743472245, 35192.47211291884, 36401.817990909876, 36540.903772885795, 48431.5156848427, 50362.2445663308, 50570.0, 50862.491375085774, 50932.74533627308, 7606.695732170651, 7726.304632583095, 7731.845363092819, 7739.264769846855, 7820.5307681537015, 10448.582056717647, 11268.154888383568, 11276.830847537129, 11395.430228488376, 11652.825207621723, 9439.442491988744, 9684.661036863676, 9713.125818676353, 9969.800603987735, 10131.392116473035, 9476.431414115175, 9759.463229522444, 9999.150072243941, 10124.493775311057, 10164.695059148238, 9839.163671088038, 10035.297529172887, 10107.444090575089, 10274.383536987805, 10360.68917932433, 7292.744753933587, 7611.885821712568, 7825.3739700824935, 7850.960745196237, 7886.881696774668, 9358.409070457903, 9562.18721408688, 9600.32797704154, 9630.422174669542, 10102.949485252526], "value": 8931.764665792247, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.3172742947102, 1446.5660301909427, 1530.5867415797734, 1690.6280618263977, 1729.7405389191626, 7022.5435346702425, 7590.77227683169, 7681.615919204039, 7979.481333713305, 7998.920010799898, 7730.65212065457, 7810.804729881742, 7915.604219789002, 7933.801654958629, 7950.562719050465, 2270.6026445372117, 2337.345543247893, 2337.520808234308, 2337.544178885118, 2339.812814974798, 2278.6354183330586, 2298.8735619540917, 2329.6505524171425, 2341.0635745701684, 2342.543204075206, 2311.399036250579, 2339.730930942938, 2346.143657564985, 2347.3779448446176, 2348.8590684558894, 2242.4281808138903, 2246.0454306919573, 2255.5037891663806, 2256.627656436686, 2283.041122728458, 2230.3309007297908, 2249.089118906845, 2258.559580881729, 2266.909323627053, 2272.034385386221, 7976.401769867225, 8017.639206235734, 8021.719239826636, 8059.274665280094, 8076.4750291230885, 4780.330753694486, 4952.405711314629, 4975.0, 4978.452370239271, 4996.7501624918605, 2947.8378689172087, 2954.1137658702305, 3056.144279601715, 3057.4649436348773, 3070.0482850316475, 969.5782334684435, 974.5614473486959, 979.4466126638426, 998.2862253488718, 1017.7811770469384, 10526.631567895087, 10730.302530335503, 10770.192235582363, 10786.406747628876, 10833.241673082888, 4399.14216727735, 4477.395551600557, 4655.674102812838, 4664.440267167962, 4691.132140554008, 9256.07439256069, 9258.768530786785, 9270.490123043162, 9275.72172834816, 9323.440593564408, 4899.8285060023445, 4905.852824415273, 4906.632002599819, 4920.778564964585, 4936.456989731127, 3781.0925377909653, 4313.439252897166, 4445.711028783118, 4447.0, 4452.0205554777895, 3633.454981752758, 3663.6336366363685, 3716.6283371662616, 3768.095657042345, 3779.4897688811657, 1217.4034722985673, 1234.7098431868503, 1240.8324876141785, 1241.6399244219256, 1247.681841130506, 772.1660606544918, 780.3328154427996, 783.1815752538611, 783.5494590610308, 798.0383637716537, 4944.876378090505, 5164.0, 5274.947250527445, 5382.434844341366, 5532.197831314437, 828.4615000249886, 867.6876324523166, 883.1565854608833, 900.7838118851429, 906.2342320738965, 3522.6653467920505, 3566.8573257069947, 3655.6527129922615, 3698.2973235085246, 3750.8499660013294, 9505.194013137481, 9785.07041831025, 9865.457399842933, 9910.950445247727, 9913.157381622643, 9729.756756081155, 9736.123748862494, 9736.123748862636, 9797.755056123511, 9809.460479673686, 7395.149557800814, 7578.355839753573, 7595.734149304858, 7611.467197296136, 7641.350485208708, 4880.097182021337, 4966.379202599675, 5130.153524668388, 5168.0697474454955, 5317.8404647860625, 9044.231240344645, 9059.773505662148, 9135.817283654156, 9171.266298695955, 9181.265498759949, 9101.135392137736, 9174.862377064215, 9327.16055554976, 9336.066393360881, 9377.718668439958, 6130.356312587114, 6130.356312587292, 6583.177102862142, 6880.0, 6886.345797149263, 7438.5536867788105, 7463.888041679488, 7472.178060413242, 7474.5888976106835, 7556.093268807778, 6605.372489613671, 6781.864362712817, 6809.319068093349, 6871.175458944958, 6884.896726549206, 6610.8016759497295, 6648.434883034803, 6725.932740672531, 6753.15585551806, 6849.691763870737, 5991.460768530853, 6215.471684906834, 6250.656213908279, 6276.403741644536, 6347.777827776005, 4125.711200215956, 4155.8753237402925, 4170.332746760504, 4230.640395566411, 4236.195122926757, 4314.115606300764, 4324.978375108104, 4355.934660980151, 4390.670699697472, 4426.867193984185], "value": 4220.809282095017, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.63630642913864, 319.29913839123117, 322.3166886201252, 324.98862539811114, 326.7010685223021, 5327.360716713995, 5408.161734931087, 5420.4850539198815, 5420.647657902244, 5440.374356948947, 5342.813001544947, 5344.385395679498, 5347.171188465794, 5355.196720491928, 5362.65142765721, 3930.469386632804, 4031.8387264509383, 4125.938110928339, 4139.461869956916, 4166.10428757817, 4152.854650087247, 4165.958340416587, 4177.707560470768, 4180.79096045198, 4183.686223533247, 4151.854685086023, 4153.460050193486, 4159.313713237312, 4159.750414975096, 4160.292750232467, 4045.4336392905016, 4148.668106551469, 4167.291560434718, 4169.958300417018, 4178.603032711888, 3668.5414323209598, 3680.2639472105684, 3681.613430589803, 3682.5949145593963, 3689.9631003689888, 5109.259157422153, 5131.692098474104, 5139.229115632647, 5153.1497302945345, 5163.096458119851, 4411.977940110311, 4694.741789201593, 4797.232442809169, 4818.277258411266, 4818.542238487338, 5533.806316778893, 5536.2249285100115, 5640.294963129609, 5644.040513112781, 5648.604597678164, 3919.902002449933, 3920.7255492115564, 3926.155876486569, 3930.744501607386, 3942.7240093193486, 5805.158252053471, 5845.81768112907, 5903.173555702205, 5965.701714914237, 5982.102684597302, 4001.099752555652, 4023.436718859362, 4033.6369726724733, 4035.5762644922447, 4044.292248856438, 4075.59244075596, 4089.5501494835544, 4089.591040895946, 4091.217971779159, 4095.9385609215888, 4601.654875884322, 4703.247480403119, 4707.646926480527, 4709.222978208626, 4713.929291060636, 5644.181593668895, 5671.546276297886, 5674.319081710221, 5697.686627235542, 5701.686407247641, 1382.5437605590132, 1403.733290674789, 1420.4105296302125, 1422.9217393043482, 1424.1383962702623, 858.0, 917.8485549884327, 943.2736792669606, 960.8709766024892, 963.7157038673608, 4817.975910120427, 4901.362822833009, 4914.72968986702, 4917.139500587383, 4930.9506904930495, 5731.340895797037, 5762.625429347163, 5788.957987562195, 5800.158976948319, 5810.738516766755, 4759.16714574948, 4859.2954021666665, 4882.438519570223, 4897.681650692693, 4914.459409464956, 3097.5818264534, 3102.193429708292, 3117.298607813224, 3124.375124975014, 3136.325689976666, 5380.166074258496, 5381.408045115034, 5388.46115388458, 5397.8380648580605, 5414.8104816332025, 5773.88452230953, 5866.882662346729, 5960.791372301948, 5965.7613695452565, 5979.372165922602, 5355.3841308249275, 5399.946000540023, 5405.162199859028, 5406.864828379244, 5413.431589683027, 5552.805651802168, 5759.7408116634015, 5776.191333213437, 5794.0, 5820.679862607428, 5684.090545512699, 5687.289088863892, 5696.458836410535, 5705.144228365778, 5709.743061562157, 5323.361196656426, 5378.650387724785, 5404.83785486436, 5443.564514838724, 5454.100073487989, 3803.8668646597234, 3993.4209539616013, 4009.318415869251, 4035.071933455263, 4062.8374865005067, 5780.653160810197, 5812.505936995402, 5817.331006934088, 5825.155352473952, 5827.3007239131575, 5651.8304450866535, 5654.575906807088, 5663.433656634304, 5680.6591604503865, 5704.686242256716, 5524.281843360337, 5657.464084946908, 5661.830145095653, 5665.603407761582, 5710.086386178192, 5342.0, 5556.277683901067, 5585.720713964204, 5595.0, 5604.3835178131185, 5582.190582365615, 5737.91393129095, 5742.454466825645, 5745.626534275259, 5773.422657734361, 5530.230326295547, 5545.916811247916, 5567.526760225426, 5571.164325351229, 5573.136163894603], "value": 4213.951995196498, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.5270076493779, 721.7221369772636, 752.8682480565901, 764.1250767870791, 764.9541027538348, 12074.275543467398, 12243.0, 12269.386530673464, 12299.815502767466, 12420.130590858644, 11719.824202636946, 11748.765024699502, 11749.53001879926, 11790.764184716301, 11810.704732381695, 622.5797586629008, 711.5659447736876, 771.8494893495756, 784.705735349244, 786.6420778545777, 780.1457404142454, 784.1178673991759, 787.0751866556801, 790.3953475591177, 791.0783936713722, 821.1993306526149, 826.7271800305884, 827.8054657155564, 829.4732844643635, 829.6598394658191, 821.1542111625035, 823.2220551578761, 824.2540500846743, 824.6660102658433, 825.2613910550054, 599.8920194365013, 603.3242768099713, 604.0365616841132, 604.9879002419927, 607.76601008612, 12558.81161782574, 12573.559925402658, 12577.05672074589, 12667.746645067047, 12683.302418366986, 11897.940510297392, 12219.694507637292, 12230.14388992771, 12317.56888508907, 12507.49970001199, 10940.45297735118, 10952.835707464394, 11098.611548595842, 11167.329960202414, 11413.771724565462, 4250.851220207309, 4257.318828987378, 4274.786260686984, 4311.8706438806885, 4369.650427965787, 48202.0, 48279.517204827855, 49235.0, 49317.506824931654, 49350.75324623426, 9255.213306868991, 9482.525873706287, 9579.712608621752, 9637.084476974676, 9699.127078562964, 15703.371865125495, 15736.134512601917, 15746.921265393828, 15781.210939452982, 17921.910390447963, 7005.614691191931, 7007.684654190573, 7010.684519196649, 7024.578525288397, 7081.398081163159, 3674.9632503675157, 3755.6619904208205, 3824.4263360496147, 3829.4255861620422, 3866.7486613370043, 2872.3967966726805, 2925.956110658342, 2939.5737618045264, 2940.0, 2945.5434407666844, 507.1910303066603, 507.81210951947276, 512.2086376548242, 520.4795204795205, 521.4290352064484, 571.6427232979388, 590.10598942602, 600.5825950964038, 608.5131894484394, 609.7347653770624, 7391.963040184764, 7395.0, 7483.2516748325825, 7573.545587264782, 7747.690092396241, 454.18927214921865, 481.8000529780172, 542.6852425593147, 544.7657507271911, 545.370097537345, 3362.529245905575, 3399.218179818606, 3402.625711171769, 3435.2442462658173, 3542.769719968194, 53897.46102539003, 54403.0, 54604.45395546073, 54702.0, 55011.72494137504, 47562.0, 47935.28097078547, 48133.5186648129, 48260.517394826304, 48425.757871210415, 42909.141817164105, 43211.35182972258, 43403.34894976578, 43406.348904766455, 44117.77941110274, 6733.797986060426, 6798.354156355138, 6809.659517024228, 6868.038474613458, 6886.69009894566, 28607.9987200447, 28794.42411151807, 29252.268693282836, 29564.556531652473, 29749.10752677423, 35587.82206088953, 36922.0, 38977.41533877051, 39097.804510977265, 39555.20889582135, 9192.0, 9212.723618291462, 9308.674196403093, 9368.906310936803, 9452.527373631428, 9185.357025008185, 9799.755006124904, 9864.950675246579, 9967.40195588267, 9995.300328977193, 8962.32782541299, 9177.541122943692, 9218.815623687622, 9232.169104780602, 9297.72106836796, 8923.268250217634, 9016.639334426813, 9182.403143795633, 9351.5791789371, 9527.523623818919, 9196.402233854778, 9220.712025631427, 9456.196223321094, 9473.763155921157, 9495.19290860257, 7854.842903141791, 7973.720919768012, 7993.520388776692, 8046.798830029296, 8198.631061602124, 8016.496074729067, 8037.156098609562, 8089.2315230053055, 8124.309433698202, 8410.243078122998], "value": 5715.098636471916, "unit": "score"}], "name": "dromaeo_css", "value": 6383.293220480895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 114.0, 114.0, 114.0, 127.0, 114.0, 116.0, 112.0, 112.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 133.0, 160.0, 185.0, 137.0, 160.0, 153.0, 133.0, 194.0, 138.0], "value": 155.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 177.0, 163.0, 162.0, 163.0, 163.0, 167.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 77.0, 149.0, 75.0, 76.0, 76.0, 76.0, 154.0, 75.0], "value": 90.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 143.0, 95.0, 94.0, 93.0, 152.0, 94.0, 94.0, 145.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 118.0, 130.0, 121.0, 125.0, 122.0, 118.0], "value": 120.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 149.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 97.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 67.0, 66.0, 65.0, 64.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 81.0, 79.0, 81.0, 80.0, 83.0, 81.0, 117.0, 80.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 135.0, 148.0, 138.0, 139.0, 135.0, 135.0, 148.0, 135.0, 135.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 180.0, 183.0, 177.0, 179.0, 179.0, 179.0, 175.0, 176.0, 180.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 72.0, 74.0, 78.0, 74.0, 75.0, 72.0, 78.0], "value": 74.6, "unit": "score"}], "name": "kraken", "value": 1607.1999999999998, "alertThreshold": 2.0}]} 05:44:37 INFO - Return code: 0 05:44:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:44:37 ERROR - # TBPL SUCCESS # 05:44:37 INFO - Running post-action listener: _resource_record_post_action 05:44:37 INFO - Running post-run listener: _resource_record_post_run 05:44:38 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518443008; Read time: 4; Write time: 375856 05:44:38 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234643456; Read time: 0; Write time: 220836 05:44:38 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283799552; Read time: 4; Write time: 155020 05:44:38 INFO - Running post-run listener: _upload_blobber_files 05:44:38 INFO - Blob upload gear active. 05:44:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:44:38 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 05:44:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:44:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:44:38 INFO - (blobuploader) - INFO - Open directory for files ... 05:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:44:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:39 INFO - (blobuploader) - INFO - Done attempting. 05:44:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:44:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:44:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:40 INFO - (blobuploader) - INFO - Done attempting. 05:44:40 INFO - (blobuploader) - INFO - Iteration through files over. 05:44:40 INFO - Return code: 0 05:44:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:44:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:44:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a9c6372536fbb29e38105ce46f5a9dbf034ce4fb83d5f2063a1dfae1093da70f492642e5b0f2c531dfce97aeb2fa9054d84533c7fb90d164b41a37196dada6e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e730d000fc0dc3da14c3df8256d5951f87ee99e75b8dc5855c6bd0eaec6991aa16b88091fb193f8a22b768f2ea16e0fe09cdf73cd89bebfafd9e62d7b0a61ce2"} 05:44:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:44:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:44:40 INFO - Contents: 05:44:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a9c6372536fbb29e38105ce46f5a9dbf034ce4fb83d5f2063a1dfae1093da70f492642e5b0f2c531dfce97aeb2fa9054d84533c7fb90d164b41a37196dada6e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e730d000fc0dc3da14c3df8256d5951f87ee99e75b8dc5855c6bd0eaec6991aa16b88091fb193f8a22b768f2ea16e0fe09cdf73cd89bebfafd9e62d7b0a61ce2"} 05:44:40 INFO - Running post-run listener: copy_logs_to_upload_dir 05:44:40 INFO - Copying logs to upload dir... 05:44:40 INFO - mkdir: /builds/slave/test/build/upload/logs 05:44:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.945302 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-04-25 05:44:37.999707) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:44:38.003050) ========= 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=82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a9c6372536fbb29e38105ce46f5a9dbf034ce4fb83d5f2063a1dfae1093da70f492642e5b0f2c531dfce97aeb2fa9054d84533c7fb90d164b41a37196dada6e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e730d000fc0dc3da14c3df8256d5951f87ee99e75b8dc5855c6bd0eaec6991aa16b88091fb193f8a22b768f2ea16e0fe09cdf73cd89bebfafd9e62d7b0a61ce2"} build_url:https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/D5pYoYECQPOA_-xi3A8o-g/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2a9c6372536fbb29e38105ce46f5a9dbf034ce4fb83d5f2063a1dfae1093da70f492642e5b0f2c531dfce97aeb2fa9054d84533c7fb90d164b41a37196dada6e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e730d000fc0dc3da14c3df8256d5951f87ee99e75b8dc5855c6bd0eaec6991aa16b88091fb193f8a22b768f2ea16e0fe09cdf73cd89bebfafd9e62d7b0a61ce2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:44:38.029000) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:44:38.029304) ========= 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=82e07478c745e68b1fe4678a000001bc-1461587044.24935-1194151977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:44:38.111438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:44:38.111751) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:44:38.112031) ========= ========= Total master_lag: 0.16 =========