builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1466013878.96 results: success (0) buildid: 20160615092122 builduid: d299044384ff4f30b5cd0dc13c2f8332 revision: e0eca48096b6d8ae32b7bc01cabc66e5990c0729 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:38.963801) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:38.964288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:38.964575) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:38.979585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:38.979886) ========= 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=fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-15 11:04:39-- 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% 87.4M=0s 2016-06-15 11:04:39 (87.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:39.120248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:39.120557) ========= 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=fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014280 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:39.170090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:39.170411) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e0eca48096b6d8ae32b7bc01cabc66e5990c0729 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e0eca48096b6d8ae32b7bc01cabc66e5990c0729 --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=fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-15 11:04:39,499 truncating revision to first 12 chars 2016-06-15 11:04:39,499 Setting DEBUG logging. 2016-06-15 11:04:39,499 attempt 1/10 2016-06-15 11:04:39,499 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e0eca48096b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-15 11:04:39,800 unpacking tar archive at: mozilla-beta-e0eca48096b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635749 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:39.821561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:39.821889) ========= script_repo_revision: e0eca48096b6d8ae32b7bc01cabc66e5990c0729 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:39.822308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:39.822588) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-15 11:04:39.838157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-15 11:04:39.838434) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:04:40 INFO - MultiFileLogger online at 20160615 11:04:40 in /builds/slave/test 11:04:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:04:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:04:40 INFO - {'append_to_log': False, 11:04:40 INFO - 'base_work_dir': '/builds/slave/test', 11:04:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:04:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:04:40 INFO - 'branch': 'Mozilla-Beta', 11:04:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:04:40 INFO - 'config_files': ('talos/linux_config.py',), 11:04:40 INFO - 'default_actions': ('clobber', 11:04:40 INFO - 'read-buildbot-config', 11:04:40 INFO - 'download-and-extract', 11:04:40 INFO - 'populate-webroot', 11:04:40 INFO - 'create-virtualenv', 11:04:40 INFO - 'install', 11:04:40 INFO - 'run-tests'), 11:04:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:04:40 INFO - 'download_minidump_stackwalk': True, 11:04:40 INFO - 'download_symbols': 'ondemand', 11:04:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:04:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:04:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:04:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:04:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:04:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:04:40 INFO - 'installer_path': 'installer.exe', 11:04:40 INFO - 'log_level': 'info', 11:04:40 INFO - 'log_name': 'talos', 11:04:40 INFO - 'log_to_console': True, 11:04:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:04:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:04:40 INFO - 'opt_config_files': (), 11:04:40 INFO - 'pip_index': False, 11:04:40 INFO - 'sps_profile': False, 11:04:40 INFO - 'sps_profile_interval': 0, 11:04:40 INFO - 'suite': 'dromaeojs-e10s', 11:04:40 INFO - 'system_bits': '32', 11:04:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:04:40 INFO - 'title': 'talos-linux64-ix-048', 11:04:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:04:40 INFO - 'use_talos_json': True, 11:04:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:04:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:04:40 INFO - 'work_dir': 'build'} 11:04:40 INFO - ##### 11:04:40 INFO - ##### Running clobber step. 11:04:40 INFO - ##### 11:04:40 INFO - Running pre-action listener: _resource_record_pre_action 11:04:40 INFO - Running main action method: clobber 11:04:40 INFO - rmtree: /builds/slave/test/build 11:04:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:04:41 INFO - Running post-action listener: _resource_record_post_action 11:04:41 INFO - ##### 11:04:41 INFO - ##### Running read-buildbot-config step. 11:04:41 INFO - ##### 11:04:41 INFO - Running pre-action listener: _resource_record_pre_action 11:04:41 INFO - Running main action method: read_buildbot_config 11:04:41 INFO - Using buildbot properties: 11:04:41 INFO - { 11:04:41 INFO - "project": "", 11:04:41 INFO - "product": "firefox", 11:04:41 INFO - "script_repo_revision": "production", 11:04:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:04:41 INFO - "repository": "", 11:04:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 11:04:41 INFO - "buildid": "20160615092122", 11:04:41 INFO - "pgo_build": "True", 11:04:41 INFO - "basedir": "/builds/slave/test", 11:04:41 INFO - "buildnumber": 139, 11:04:41 INFO - "slavename": "talos-linux64-ix-048", 11:04:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:04:41 INFO - "platform": "ubuntu64_hw", 11:04:41 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:04:41 INFO - "branch": "mozilla-beta", 11:04:41 INFO - "repo_path": "releases/mozilla-beta", 11:04:41 INFO - "revision": "e0eca48096b6d8ae32b7bc01cabc66e5990c0729", 11:04:41 INFO - "stage_platform": "linux64-pgo", 11:04:41 INFO - "builduid": "d299044384ff4f30b5cd0dc13c2f8332", 11:04:41 INFO - "slavebuilddir": "test" 11:04:41 INFO - } 11:04:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 11:04:41 INFO - Running post-action listener: _resource_record_post_action 11:04:41 INFO - ##### 11:04:41 INFO - ##### Running download-and-extract step. 11:04:41 INFO - ##### 11:04:41 INFO - Running pre-action listener: _resource_record_pre_action 11:04:41 INFO - Running main action method: download_and_extract 11:04:41 INFO - mkdir: /builds/slave/test/build/tests 11:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:41 INFO - https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:04:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:04:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:04:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:04:43 INFO - Downloaded 1327 bytes. 11:04:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 11:04:43 INFO - Using the following test package requirements: 11:04:43 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:04:43 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:04:43 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:04:43 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:04:43 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 11:04:43 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:04:43 INFO - u'jsshell-linux-x86_64.zip'], 11:04:43 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:04:43 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:04:43 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 11:04:43 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:04:43 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 11:04:43 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:04:43 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 11:04:43 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:04:43 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:04:43 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 11:04:43 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:04:43 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:43 INFO - https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:04:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:04:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:04:44 INFO - Downloaded 24185729 bytes. 11:04:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:04:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:04:45 INFO - Return code: 0 11:04:45 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:04:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:45 INFO - https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:04:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:04:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:04:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 11:04:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:04:57 INFO - Downloaded 24185729 bytes. 11:04:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:04:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:04:59 INFO - Return code: 0 11:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:04:59 INFO - https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 11:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:05:00 INFO - Downloaded 10840145 bytes. 11:05:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:05:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:05:00 INFO - Return code: 0 11:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:00 INFO - https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:05:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:05:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:05:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:05:02 INFO - Downloaded 56020679 bytes. 11:05:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:05:02 INFO - mkdir: /builds/slave/test/properties 11:05:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:05:02 INFO - Writing to file /builds/slave/test/properties/build_url 11:05:02 INFO - Contents: 11:05:02 INFO - build_url:https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 11:05:02 INFO - Running post-action listener: _resource_record_post_action 11:05:02 INFO - Running post-action listener: set_extra_try_arguments 11:05:02 INFO - ##### 11:05:02 INFO - ##### Running populate-webroot step. 11:05:02 INFO - ##### 11:05:02 INFO - Running pre-action listener: _resource_record_pre_action 11:05:02 INFO - Running main action method: populate_webroot 11:05:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:05:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:05:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:05:02 INFO - '--tppagecycles', 11:05:02 INFO - '7'], 11:05:02 INFO - 'tests': ['tsvgm']}}, 11:05:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:05:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:05:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:05:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:05:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:02 INFO - 'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:02 INFO - 'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['damp', 'tps']}, 11:05:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:02 INFO - 'tests': ['damp', 'tps']}, 11:05:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['dromaeo_dom']}, 11:05:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:05:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['a11yr', 11:05:02 INFO - 'ts_paint', 11:05:02 INFO - 'tpaint', 11:05:02 INFO - 'sessionrestore', 11:05:02 INFO - 'sessionrestore_no_auto_restore', 11:05:02 INFO - 'tabpaint']}, 11:05:02 INFO - 'other-e10s': {'tests': ['a11yr', 11:05:02 INFO - 'ts_paint', 11:05:02 INFO - 'tpaint', 11:05:02 INFO - 'sessionrestore', 11:05:02 INFO - 'sessionrestore_no_auto_restore', 11:05:02 INFO - 'tabpaint']}, 11:05:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:05:02 INFO - 'ts_paint', 11:05:02 INFO - 'tpaint', 11:05:02 INFO - 'sessionrestore', 11:05:02 INFO - 'sessionrestore_no_auto_restore', 11:05:02 INFO - 'tabpaint']}, 11:05:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:05:02 INFO - 'ts_paint', 11:05:02 INFO - 'tpaint', 11:05:02 INFO - 'sessionrestore', 11:05:02 INFO - 'sessionrestore_no_auto_restore', 11:05:02 INFO - 'tabpaint']}, 11:05:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['a11yr', 11:05:02 INFO - 'ts_paint', 11:05:02 INFO - 'tpaint', 11:05:02 INFO - 'sessionrestore', 11:05:02 INFO - 'sessionrestore_no_auto_restore', 11:05:02 INFO - 'tabpaint']}, 11:05:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['a11yr', 11:05:02 INFO - 'ts_paint', 11:05:02 INFO - 'tpaint', 11:05:02 INFO - 'sessionrestore', 11:05:02 INFO - 'sessionrestore_no_auto_restore', 11:05:02 INFO - 'tabpaint']}, 11:05:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['tsvgx', 11:05:02 INFO - 'tsvgr_opacity', 11:05:02 INFO - 'tart', 11:05:02 INFO - 'tscrollx', 11:05:02 INFO - 'cart']}, 11:05:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:05:02 INFO - 'tsvgr_opacity', 11:05:02 INFO - 'tart', 11:05:02 INFO - 'tscrollx', 11:05:02 INFO - 'cart']}, 11:05:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:02 INFO - 'talos_options': ['--disable-e10s'], 11:05:02 INFO - 'tests': ['tp5o']}, 11:05:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:02 INFO - 'tests': ['tp5o']}, 11:05:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:02 INFO - 'talos_options': ['--disable-e10s', 11:05:02 INFO - '--xperf_path', 11:05:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:02 INFO - 'tests': ['tp5n']}, 11:05:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:02 INFO - 'talos_options': ['--xperf_path', 11:05:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:02 INFO - 'tests': ['tp5n']}}, 11:05:02 INFO - 'talos.zip': {'path': '', 11:05:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:05:02 INFO - Running post-action listener: _resource_record_post_action 11:05:02 INFO - ##### 11:05:02 INFO - ##### Running create-virtualenv step. 11:05:02 INFO - ##### 11:05:02 INFO - Running pre-action listener: _resource_record_pre_action 11:05:02 INFO - Running main action method: create_virtualenv 11:05:02 INFO - Creating virtualenv /builds/slave/test/build/venv 11:05:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:05:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:05:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:05:02 INFO - Using real prefix '/usr' 11:05:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:05:03 INFO - Installing distribute.............................................................................................................................................................................................done. 11:05:05 INFO - Installing pip.................done. 11:05:05 INFO - Return code: 0 11:05:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0104351f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, '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': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:05:05 INFO - Using env: {'DISPLAY': ':0', 11:05:05 INFO - 'HOME': '/home/cltbld', 11:05:05 INFO - 'LANG': 'en_US.UTF-8', 11:05:05 INFO - 'LANGUAGE': 'en_US:en', 11:05:05 INFO - 'LOGNAME': 'cltbld', 11:05:05 INFO - 'MAIL': '/var/mail/cltbld', 11:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:05 INFO - 'MOZ_NO_REMOTE': '1', 11:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:05 INFO - 'NO_EM_RESTART': '1', 11:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:05 INFO - 'PWD': '/builds/slave/test', 11:05:05 INFO - 'SHELL': '/bin/bash', 11:05:05 INFO - 'SHLVL': '1', 11:05:05 INFO - 'TERM': 'linux', 11:05:05 INFO - 'TMOUT': '86400', 11:05:05 INFO - 'USER': 'cltbld', 11:05:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:05 INFO - '_': '/tools/buildbot/bin/python'} 11:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:05:05 INFO - Cleaning up... 11:05:05 INFO - Return code: 0 11:05:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0104351f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, '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': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:05:05 INFO - Using env: {'DISPLAY': ':0', 11:05:05 INFO - 'HOME': '/home/cltbld', 11:05:05 INFO - 'LANG': 'en_US.UTF-8', 11:05:05 INFO - 'LANGUAGE': 'en_US:en', 11:05:05 INFO - 'LOGNAME': 'cltbld', 11:05:05 INFO - 'MAIL': '/var/mail/cltbld', 11:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:05 INFO - 'MOZ_NO_REMOTE': '1', 11:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:05 INFO - 'NO_EM_RESTART': '1', 11:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:05 INFO - 'PWD': '/builds/slave/test', 11:05:05 INFO - 'SHELL': '/bin/bash', 11:05:05 INFO - 'SHLVL': '1', 11:05:05 INFO - 'TERM': 'linux', 11:05:05 INFO - 'TMOUT': '86400', 11:05:05 INFO - 'USER': 'cltbld', 11:05:05 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:05 INFO - '_': '/tools/buildbot/bin/python'} 11:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:05 INFO - Downloading/unpacking psutil>=0.7.1 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:05:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:07 INFO - Installing collected packages: psutil 11:05:07 INFO - Running setup.py install for psutil 11:05:08 INFO - building 'psutil._psutil_linux' extension 11:05:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:05:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:05:08 INFO - building 'psutil._psutil_posix' extension 11:05:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:05:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:05:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:08 INFO - Successfully installed psutil 11:05:08 INFO - Cleaning up... 11:05:08 INFO - Return code: 0 11:05:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0104351f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, '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': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:05:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 11:05:08 INFO - Using env: {'DISPLAY': ':0', 11:05:08 INFO - 'HOME': '/home/cltbld', 11:05:08 INFO - 'LANG': 'en_US.UTF-8', 11:05:08 INFO - 'LANGUAGE': 'en_US:en', 11:05:08 INFO - 'LOGNAME': 'cltbld', 11:05:08 INFO - 'MAIL': '/var/mail/cltbld', 11:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:08 INFO - 'MOZ_NO_REMOTE': '1', 11:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:08 INFO - 'NO_EM_RESTART': '1', 11:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:08 INFO - 'PWD': '/builds/slave/test', 11:05:08 INFO - 'SHELL': '/bin/bash', 11:05:08 INFO - 'SHLVL': '1', 11:05:08 INFO - 'TERM': 'linux', 11:05:08 INFO - 'TMOUT': '86400', 11:05:08 INFO - 'USER': 'cltbld', 11:05:08 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:08 INFO - '_': '/tools/buildbot/bin/python'} 11:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:05:10 INFO - Installing collected packages: mozsystemmonitor 11:05:10 INFO - Running setup.py install for mozsystemmonitor 11:05:10 INFO - Successfully installed mozsystemmonitor 11:05:10 INFO - Cleaning up... 11:05:10 INFO - Return code: 0 11:05:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0104351f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, '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': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:05:10 INFO - Using env: {'DISPLAY': ':0', 11:05:10 INFO - 'HOME': '/home/cltbld', 11:05:10 INFO - 'LANG': 'en_US.UTF-8', 11:05:10 INFO - 'LANGUAGE': 'en_US:en', 11:05:10 INFO - 'LOGNAME': 'cltbld', 11:05:10 INFO - 'MAIL': '/var/mail/cltbld', 11:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:10 INFO - 'MOZ_NO_REMOTE': '1', 11:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:10 INFO - 'NO_EM_RESTART': '1', 11:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:10 INFO - 'PWD': '/builds/slave/test', 11:05:10 INFO - 'SHELL': '/bin/bash', 11:05:10 INFO - 'SHLVL': '1', 11:05:10 INFO - 'TERM': 'linux', 11:05:10 INFO - 'TMOUT': '86400', 11:05:10 INFO - 'USER': 'cltbld', 11:05:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:10 INFO - '_': '/tools/buildbot/bin/python'} 11:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:10 INFO - Downloading/unpacking blobuploader==1.2.4 11:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:12 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:05:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:13 INFO - Downloading docopt-0.6.1.tar.gz 11:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:13 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:13 INFO - Running setup.py install for blobuploader 11:05:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:05:13 INFO - Running setup.py install for requests 11:05:14 INFO - Running setup.py install for docopt 11:05:14 INFO - Successfully installed blobuploader requests docopt 11:05:14 INFO - Cleaning up... 11:05:14 INFO - Return code: 0 11:05:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0104351f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, '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': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:05:14 INFO - Using env: {'DISPLAY': ':0', 11:05:14 INFO - 'HOME': '/home/cltbld', 11:05:14 INFO - 'LANG': 'en_US.UTF-8', 11:05:14 INFO - 'LANGUAGE': 'en_US:en', 11:05:14 INFO - 'LOGNAME': 'cltbld', 11:05:14 INFO - 'MAIL': '/var/mail/cltbld', 11:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:14 INFO - 'MOZ_NO_REMOTE': '1', 11:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:14 INFO - 'NO_EM_RESTART': '1', 11:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:14 INFO - 'PWD': '/builds/slave/test', 11:05:14 INFO - 'SHELL': '/bin/bash', 11:05:14 INFO - 'SHLVL': '1', 11:05:14 INFO - 'TERM': 'linux', 11:05:14 INFO - 'TMOUT': '86400', 11:05:14 INFO - 'USER': 'cltbld', 11:05:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:14 INFO - '_': '/tools/buildbot/bin/python'} 11:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:14 INFO - Running setup.py (path:/tmp/pip-8EirRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:14 INFO - Running setup.py (path:/tmp/pip-oAFhRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:14 INFO - Running setup.py (path:/tmp/pip-zbkJc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:14 INFO - Running setup.py (path:/tmp/pip-5lvVFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:14 INFO - Running setup.py (path:/tmp/pip-zBEQ7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:14 INFO - Running setup.py (path:/tmp/pip-io8lBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:14 INFO - Running setup.py (path:/tmp/pip-KRZpur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:14 INFO - Running setup.py (path:/tmp/pip-VBxNl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:14 INFO - Running setup.py (path:/tmp/pip-eSw47z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:15 INFO - Running setup.py (path:/tmp/pip-EWCxMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:15 INFO - Running setup.py (path:/tmp/pip-krFWw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:15 INFO - Running setup.py (path:/tmp/pip-je_1Ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:15 INFO - Running setup.py (path:/tmp/pip-NhN37G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:15 INFO - Running setup.py (path:/tmp/pip-2RQUXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:15 INFO - Running setup.py (path:/tmp/pip-ils4Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:15 INFO - Running setup.py (path:/tmp/pip-pilQgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:15 INFO - Running setup.py (path:/tmp/pip-h9Zjbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:15 INFO - Running setup.py install for manifestparser 11:05:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:15 INFO - Running setup.py install for mozcrash 11:05:15 INFO - Running setup.py install for mozdebug 11:05:15 INFO - Running setup.py install for mozdevice 11:05:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Running setup.py install for mozfile 11:05:16 INFO - Running setup.py install for mozhttpd 11:05:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Running setup.py install for mozinfo 11:05:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Running setup.py install for mozInstall 11:05:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Running setup.py install for mozleak 11:05:16 INFO - Running setup.py install for mozlog 11:05:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Running setup.py install for moznetwork 11:05:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Running setup.py install for mozprocess 11:05:16 INFO - Running setup.py install for mozprofile 11:05:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:05:16 INFO - Running setup.py install for mozrunner 11:05:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:05:17 INFO - Running setup.py install for mozscreenshot 11:05:17 INFO - Running setup.py install for moztest 11:05:17 INFO - Running setup.py install for mozversion 11:05:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:05:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:17 INFO - Cleaning up... 11:05:17 INFO - Return code: 0 11:05:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0104351f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, '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': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:05:17 INFO - Using env: {'DISPLAY': ':0', 11:05:17 INFO - 'HOME': '/home/cltbld', 11:05:17 INFO - 'LANG': 'en_US.UTF-8', 11:05:17 INFO - 'LANGUAGE': 'en_US:en', 11:05:17 INFO - 'LOGNAME': 'cltbld', 11:05:17 INFO - 'MAIL': '/var/mail/cltbld', 11:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:17 INFO - 'MOZ_NO_REMOTE': '1', 11:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:17 INFO - 'NO_EM_RESTART': '1', 11:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:17 INFO - 'PWD': '/builds/slave/test', 11:05:17 INFO - 'SHELL': '/bin/bash', 11:05:17 INFO - 'SHLVL': '1', 11:05:17 INFO - 'TERM': 'linux', 11:05:17 INFO - 'TMOUT': '86400', 11:05:17 INFO - 'USER': 'cltbld', 11:05:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:17 INFO - '_': '/tools/buildbot/bin/python'} 11:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:17 INFO - Running setup.py (path:/tmp/pip-H1OQSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:17 INFO - Running setup.py (path:/tmp/pip-oGnwrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:17 INFO - Running setup.py (path:/tmp/pip-2dJBdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:17 INFO - Running setup.py (path:/tmp/pip-uosVYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:17 INFO - Running setup.py (path:/tmp/pip-za4czL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:18 INFO - Running setup.py (path:/tmp/pip-QjYwlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:18 INFO - Running setup.py (path:/tmp/pip-9IbfHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:18 INFO - Running setup.py (path:/tmp/pip-t1dhVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:18 INFO - Running setup.py (path:/tmp/pip-EVBNqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:18 INFO - Running setup.py (path:/tmp/pip-1_1Q2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:18 INFO - Running setup.py (path:/tmp/pip-AMPbzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:18 INFO - Running setup.py (path:/tmp/pip-W6OZ4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:18 INFO - Running setup.py (path:/tmp/pip-zhEbqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:18 INFO - Running setup.py (path:/tmp/pip-ApZYO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:18 INFO - Running setup.py (path:/tmp/pip-0v_kRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:18 INFO - Running setup.py (path:/tmp/pip-lihGi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:18 INFO - Running setup.py (path:/tmp/pip-eJ_6cU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:05:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:20 INFO - Downloading blessings-1.6.tar.gz 11:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:05:20 INFO - Installing collected packages: blessings 11:05:20 INFO - Running setup.py install for blessings 11:05:20 INFO - Successfully installed blessings 11:05:20 INFO - Cleaning up... 11:05:21 INFO - Return code: 0 11:05:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:05:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:21 INFO - Reading from file tmpfile_stdout 11:05:21 INFO - Current package versions: 11:05:21 INFO - argparse == 1.2.1 11:05:21 INFO - blessings == 1.6 11:05:21 INFO - blobuploader == 1.2.4 11:05:21 INFO - docopt == 0.6.1 11:05:21 INFO - manifestparser == 1.1 11:05:21 INFO - mozInstall == 1.12 11:05:21 INFO - mozcrash == 0.17 11:05:21 INFO - mozdebug == 0.1 11:05:21 INFO - mozdevice == 0.48 11:05:21 INFO - mozfile == 1.2 11:05:21 INFO - mozhttpd == 0.7 11:05:21 INFO - mozinfo == 0.9 11:05:21 INFO - mozleak == 0.1 11:05:21 INFO - mozlog == 3.1 11:05:21 INFO - moznetwork == 0.27 11:05:21 INFO - mozprocess == 0.22 11:05:21 INFO - mozprofile == 0.28 11:05:21 INFO - mozrunner == 6.11 11:05:21 INFO - mozscreenshot == 0.1 11:05:21 INFO - mozsystemmonitor == 0.0 11:05:21 INFO - moztest == 0.7 11:05:21 INFO - mozversion == 1.4 11:05:21 INFO - psutil == 3.1.1 11:05:21 INFO - requests == 1.2.3 11:05:21 INFO - wsgiref == 0.1.2 11:05:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0104351f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, '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': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:05:21 INFO - Using env: {'DISPLAY': ':0', 11:05:21 INFO - 'HOME': '/home/cltbld', 11:05:21 INFO - 'LANG': 'en_US.UTF-8', 11:05:21 INFO - 'LANGUAGE': 'en_US:en', 11:05:21 INFO - 'LOGNAME': 'cltbld', 11:05:21 INFO - 'MAIL': '/var/mail/cltbld', 11:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:21 INFO - 'MOZ_NO_REMOTE': '1', 11:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:21 INFO - 'NO_EM_RESTART': '1', 11:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:21 INFO - 'PWD': '/builds/slave/test', 11:05:21 INFO - 'SHELL': '/bin/bash', 11:05:21 INFO - 'SHLVL': '1', 11:05:21 INFO - 'TERM': 'linux', 11:05:21 INFO - 'TMOUT': '86400', 11:05:21 INFO - 'USER': 'cltbld', 11:05:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:21 INFO - '_': '/tools/buildbot/bin/python'} 11:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:05:21 INFO - Cleaning up... 11:05:21 INFO - Return code: 0 11:05:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0104351f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, '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': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:05:21 INFO - Using env: {'DISPLAY': ':0', 11:05:21 INFO - 'HOME': '/home/cltbld', 11:05:21 INFO - 'LANG': 'en_US.UTF-8', 11:05:21 INFO - 'LANGUAGE': 'en_US:en', 11:05:21 INFO - 'LOGNAME': 'cltbld', 11:05:21 INFO - 'MAIL': '/var/mail/cltbld', 11:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:21 INFO - 'MOZ_NO_REMOTE': '1', 11:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:21 INFO - 'NO_EM_RESTART': '1', 11:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:21 INFO - 'PWD': '/builds/slave/test', 11:05:21 INFO - 'SHELL': '/bin/bash', 11:05:21 INFO - 'SHLVL': '1', 11:05:21 INFO - 'TERM': 'linux', 11:05:21 INFO - 'TMOUT': '86400', 11:05:21 INFO - 'USER': 'cltbld', 11:05:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:21 INFO - '_': '/tools/buildbot/bin/python'} 11:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:21 INFO - Downloading/unpacking jsonschema 11:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:05:23 INFO - Downloading/unpacking functools32 (from jsonschema) 11:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:23 INFO - Downloading functools32-3.2.3-2.tar.gz 11:05:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:05:23 INFO - warning: no files found matching '*.txt' 11:05:23 INFO - no previously-included directories found matching 'build' 11:05:23 INFO - no previously-included directories found matching 'dist' 11:05:23 INFO - no previously-included directories found matching '.git*' 11:05:23 INFO - Installing collected packages: jsonschema, functools32 11:05:23 INFO - Running setup.py install for functools32 11:05:23 INFO - warning: no files found matching '*.txt' 11:05:23 INFO - no previously-included directories found matching 'build' 11:05:23 INFO - no previously-included directories found matching 'dist' 11:05:23 INFO - no previously-included directories found matching '.git*' 11:05:23 INFO - Successfully installed jsonschema functools32 11:05:23 INFO - Cleaning up... 11:05:24 INFO - Return code: 0 11:05:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0104351f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e37d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, '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': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:05:24 INFO - Using env: {'DISPLAY': ':0', 11:05:24 INFO - 'HOME': '/home/cltbld', 11:05:24 INFO - 'LANG': 'en_US.UTF-8', 11:05:24 INFO - 'LANGUAGE': 'en_US:en', 11:05:24 INFO - 'LOGNAME': 'cltbld', 11:05:24 INFO - 'MAIL': '/var/mail/cltbld', 11:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:24 INFO - 'MOZ_NO_REMOTE': '1', 11:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:24 INFO - 'NO_EM_RESTART': '1', 11:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:24 INFO - 'PWD': '/builds/slave/test', 11:05:24 INFO - 'SHELL': '/bin/bash', 11:05:24 INFO - 'SHLVL': '1', 11:05:24 INFO - 'TERM': 'linux', 11:05:24 INFO - 'TMOUT': '86400', 11:05:24 INFO - 'USER': 'cltbld', 11:05:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:24 INFO - '_': '/tools/buildbot/bin/python'} 11:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:24 INFO - Downloading/unpacking flake8 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:05:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:05:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05: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 11:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:05:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:26 INFO - no previously-included directories found matching 'docs/_build' 11:05:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:05:26 INFO - Running setup.py install for pep8 11:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:05:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:05:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:05:27 INFO - no previously-included directories found matching 'docs/_build' 11:05:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:05:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:05:27 INFO - Cleaning up... 11:05:27 INFO - Return code: 0 11:05:27 INFO - Running post-action listener: _resource_record_post_action 11:05:27 INFO - Running post-action listener: _start_resource_monitoring 11:05:27 INFO - Starting resource monitoring. 11:05:27 INFO - ##### 11:05:27 INFO - ##### Running install step. 11:05:27 INFO - ##### 11:05:27 INFO - Running pre-action listener: _resource_record_pre_action 11:05:27 INFO - Running main action method: install 11:05:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:27 INFO - Reading from file tmpfile_stdout 11:05:27 INFO - Detecting whether we're running mozinstall >=1.0... 11:05:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:05:27 INFO - Reading from file tmpfile_stdout 11:05:27 INFO - Output received: 11:05:27 INFO - Usage: mozinstall [options] installer 11:05:27 INFO - Options: 11:05:27 INFO - -h, --help show this help message and exit 11:05:27 INFO - -d DEST, --destination=DEST 11:05:27 INFO - Directory to install application into. [default: 11:05:27 INFO - "/builds/slave/test"] 11:05:27 INFO - --app=APP Application being installed. [default: firefox] 11:05:27 INFO - mkdir: /builds/slave/test/build/application 11:05:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:05:40 INFO - Reading from file tmpfile_stdout 11:05:40 INFO - Output received: 11:05:40 INFO - /builds/slave/test/build/application/firefox/firefox 11:05:40 INFO - Running post-action listener: _resource_record_post_action 11:05:40 INFO - ##### 11:05:40 INFO - ##### Running run-tests step. 11:05:40 INFO - ##### 11:05:40 INFO - Running pre-action listener: _resource_record_pre_action 11:05:40 INFO - Running main action method: run_tests 11:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:05:40 INFO - Python 2.7.3 11:05:40 INFO - Return code: 0 11:05:40 INFO - grabbing minidump binary from tooltool 11:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:40 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 0x1172640>, '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 0x1173540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11739d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:05:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:05:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:05:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:05:40 INFO - Return code: 0 11:05:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:05:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:05:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:05:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:05:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:05:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:05:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:05:41 INFO - Return code: 0 11:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 11:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 11:05:41 INFO - Using env: {'DISPLAY': ':0', 11:05:41 INFO - 'HOME': '/home/cltbld', 11:05:41 INFO - 'LANG': 'en_US.UTF-8', 11:05:41 INFO - 'LANGUAGE': 'en_US:en', 11:05:41 INFO - 'LOGNAME': 'cltbld', 11:05:41 INFO - 'MAIL': '/var/mail/cltbld', 11:05:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:05:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:41 INFO - 'MOZ_NO_REMOTE': '1', 11:05:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:41 INFO - 'NO_EM_RESTART': '1', 11:05:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:41 INFO - 'PWD': '/builds/slave/test', 11:05:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:05:41 INFO - 'SHELL': '/bin/bash', 11:05:41 INFO - 'SHLVL': '1', 11:05:41 INFO - 'TERM': 'linux', 11:05:41 INFO - 'TMOUT': '86400', 11:05:41 INFO - 'USER': 'cltbld', 11:05:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662', 11:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:41 INFO - '_': '/tools/buildbot/bin/python'} 11:05:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 11:05:41 INFO - mozversion application_buildid: 20160615092122 11:05:41 INFO - mozversion application_changeset: e0eca48096b6d8ae32b7bc01cabc66e5990c0729 11:05:41 INFO - mozversion application_display_name: Firefox 11:05:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:05:41 INFO - mozversion application_name: Firefox 11:05:41 INFO - mozversion application_remotingname: firefox 11:05:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:05:41 INFO - mozversion application_vendor: Mozilla 11:05:41 INFO - mozversion application_version: 48.0 11:05:41 INFO - mozversion platform_buildid: 20160615092122 11:05:41 INFO - mozversion platform_changeset: e0eca48096b6d8ae32b7bc01cabc66e5990c0729 11:05:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:05:41 INFO - mozversion platform_version: 48.0 11:05:41 INFO - using testdate: 1466013941 11:05:41 INFO - actual date: 1466013941 11:05:41 INFO - starting webserver on 'localhost:49280' 11:05:41 INFO - SUITE-START | Running 2 tests 11:05:41 INFO - TEST-START | dromaeo_css 11:05:41 INFO - operating with platform_type : linux_ 11:05:41 INFO - Initialising browser for dromaeo_css test... 11:05:41 INFO - TEST-INFO | started process 23604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplDLz9z/profile http://localhost:49280/getInfo.html) 11:05:45 INFO - PROCESS | 23604 | 11:05:45 INFO - PROCESS | 23604 | (process:23684): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:05:46 INFO - PROCESS | 23604 | __metrics Screen width/height:1600/1200 11:05:46 INFO - PROCESS | 23604 | colorDepth:24 11:05:46 INFO - PROCESS | 23604 | Browser inner width/height: 1024/697 11:05:46 INFO - PROCESS | 23604 | __metrics 11:05:47 ERROR - PROCESS | 23604 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 11:05:48 INFO - TEST-INFO | 23604: exit 0 11:05:48 INFO - Browser initialized. 11:05:48 INFO - Running cycle 1/1 for dromaeo_css test... 11:05:48 INFO - TEST-INFO | started process 23734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplDLz9z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:05:49 INFO - PROCESS | 23734 | 11:05:49 INFO - PROCESS | 23734 | (process:23805): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:05:59 INFO - PROCESS | 23734 | RSS: Main: 151277568 11:05:59 INFO - PROCESS | 23734 | 11:06:49 INFO - PROCESS | 23734 | 1466014009506 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:08:57 INFO - PROCESS | 23734 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 11:08:58 INFO - PROCESS | 23734 | RSS: Main: 154615808 11:08:58 INFO - PROCESS | 23734 | 11:11:59 INFO - PROCESS | 23734 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 11:12:00 INFO - PROCESS | 23734 | RSS: Main: 153088000 11:12:00 INFO - PROCESS | 23734 | 11:15:02 INFO - PROCESS | 23734 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 11:15:02 INFO - PROCESS | 23734 | RSS: Main: 152690688 11:15:02 INFO - PROCESS | 23734 | 11:18:04 INFO - PROCESS | 23734 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 11:18:04 INFO - PROCESS | 23734 | RSS: Main: 154402816 11:18:04 INFO - PROCESS | 23734 | 11:21:07 INFO - PROCESS | 23734 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 11:21:07 INFO - PROCESS | 23734 | RSS: Main: 152543232 11:21:07 INFO - PROCESS | 23734 | 11:24:09 INFO - PROCESS | 23734 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 11:24:10 INFO - PROCESS | 23734 | RSS: Main: 156360704 11:24:10 INFO - PROCESS | 23734 | 11:24:10 INFO - PROCESS | 23734 | __start_tp_report 11:24:10 INFO - PROCESS | 23734 | _x_x_mozilla_page_load 11:24:10 INFO - PROCESS | 23734 | _x_x_mozilla_page_load_details 11:24:10 INFO - PROCESS | 23734 | |i|pagename|runs| 11:24:10 INFO - PROCESS | 23734 | |0;dojo.html;3390.762646614737;3427.6572342765744;3432.1076520104766;3446.46579780134;3461.567304086989;5680.573956953224;5698.8005419810315;5717.828465146053;5723.771049158028;5724.713764311783;5693.316801983768;5704.515116215116;5725.57058220633;5736.827895163141;5745.138229265613;5138.5889128869785;5173.482651734834;5189.922151167735;5233.058049551079;5254.028004819102;5189.506996835295;5218.947810521903;5227.032998895197;5248.5538729208065;5277.472252774711;5173.9482605174035;5214.243934629495;5231.79072837088;5236.188390799432;5277.340332458442;5240.082985477527;5249.658772179796;5261.789528418859;5265.183896496049;5301.840944771663;5076.390833100015;5084.084864724348;5096.566791822663;5158.148905430599;5164.690118592896;5487.890242195133;5496.890062198733;5501.174823776466;5507.228987941691;5548.029094908375;5966.481447396535;6000.309964354068;6013.15815785786;6021.849453763647;6022.156898034279;6006.309274433409;6061.272647282354;6065.302490213638;6115.727150604481;6185.474234690057;5778.88442231153;5781.508571771405;5782.190493330895;5784.942150578482;5786.88426231473;6296;6313.810585682437;6315;6317;6319.399657032574;6022.969885150546;6033.9698301508215;6039.607425517327;6099.542534309944;6108.816735497942;6053.727582258721;6101;6106.2061931948565;6168.228971378578;6178.351273116348;5928.940710592925;5951.851203719942;6083.422074902877;6122.7550897964475;6131.509479241739;6022.759089636365;6072.635641861502;6077.726502307407;6092.7562897484495;6104.11490333908;4593.494715581283;4594.494605593382;4595.287730401793;4599.448066232007;4620.283856002325;4074.4295798587627;4074.5517993020744;4113.568075352105;4124.4019617155345;4139.648129908992;5748.45389687979;5750.769969201268;5773.91339129905;5808.186853840466;5890.3815099414805;6117.480014198754;6128.448439640454;6201.658908760061;6207.224096987877;6235.719392627343;5766;5831.329397119301;5838.2702162229725;5841.912371314434;5891.734871930774;5250.369955605275;5268.710220937808;5273.446288139767;5314.92027619586;5317.707526086025;6380.298167201604;6389.808305750835;6400;6408.743650254031;6411.743530258737;6060.666663333559;6130.417610327012;6183;6216.906746398718;6222.81331560054;6284.937150628618;6289;6292.1505596743855;6294.118823364641;6294.685265736786;5951.256092988377;5955.76176952917;5960.4635582797755;5974.701264936823;5995.700214989146;5977.163197152489;6000.429959153874;6063.636181829104;6104.4505994460715;6116.33577150815;5893.44012318829;5928.67392293428;5943.791967281298;5961.552883533839;5991.610545314541;5923.08192230205;5946.524278057658;5947.6431414115295;5951.494122999594;5954.10688396744;5768.913466298093;5836.124581312837;5874.500667443144;5911.290645122441;5970.462658360769;5977.7310021050025;6001.339852616122;6020.759169633166;6037;6048.183495228088;5916.822495325147;5929.0513517836935;5933.6439813609595;5934.732937017931;5938 11:24:10 INFO - PROCESS | 23734 | |1;ext.html;599.5143933413935;648.4131860666093;653.3303364051847;666.2371584535707;674.8110529051864;33349.499757503625;34114.658853411456;40575.39136912949;41395.58604413955;41682.37476437856;43273;43749.7812510937;43842.342364864475;43871.341929871;43924.341134883005;8783.38516303859;8918.241949434307;8920.73237802867;8921.420107693011;8960.148785865333;8801.647934082628;8881.511516866569;8884.689035883745;8889.511076890769;8935.865962010575;9149.176574108329;9193.540322983825;9198.862017069749;9201.815963680723;9242.121998410174;9095.454272743624;9123.543822808866;9183.219426348769;9212.585433655468;9250.629974801;8981.461112333216;9103.31725120612;9111.681091161778;9126.13301736334;9144.131307525775;43750.343744843856;44139.337909931375;44252.3362149568;44359.112817743466;44422.111557768985;3693.372126738434;3749.531308586427;3799.7530160539477;4234.640055595278;4312.2022425851;33346.499802502985;34124.31751364984;34293;34315.828420857986;35487.4676879847;4579.977100114478;4592.517785632527;4641.187792136363;4664.650151238637;4701.623870090384;317785;320109;322295.9999999977;322500;323292;39526;60522.394776052555;61037.69481152566;61127.69436152791;61192;37961.81019094887;38037.47850086021;38207;38213.23573528514;38274.043148920944;16441.91779041097;16490.17549122539;16600.086995215137;16605.91697041507;16690.833091668926;15232.771508427382;15340;15353.232338383035;15377.38490460369;15379.84620153784;9502.667406640734;9531.285153613506;9542.713718588453;9566.473843938651;9595.760105997266;3589.9102522436624;3599.7120230381506;3606.945895811565;3670.522832031872;3679.1537946272506;1066.7706443114612;1086.9184811139196;1144.9026832719146;1204.1390405859852;1239.305988646361;33262.50106248408;33385.68900729658;33428.832855835564;33744.83127584396;33863.83068084644;1163.528770847808;1245.8131280307846;1266.66366982834;1283.4801905228398;1305.9281739504418;17520.21159047846;17588.91205543964;17691;17742.822571774374;17810.465686029438;471793;525180;532126;537545;540825;63557.682211588646;64427.35572644307;64748.67625661842;64791.676041620434;64923;1501.5495351394538;1506.5103841251637;1507.148461119464;1518.7114448254797;1524.7865298857946;33196;33406.665933341326;33887.661123388454;34106.1339487764;34184.48723269103;55583.44416555783;56048.439515604325;56063.15905261506;56237.718811405684;56567.71716141393;373021;374663;375158;375165;376934;31101.688983109878;47462.288065679735;47775.28337075016;47800.7609961948;47910.76044619754;44921;44978.100437990404;45194;45670;45859.54140458553;37740.2451950965;38256.426153607164;38336.80831595824;39522;40397.1920561593;38832.6116738829;40821.1835763289;41702.79148604359;41977.790111049246;41997.580024200586;42763.572364277206;42865.35701964411;43105.35341969936;43268.78365608152;43436.56563434325;35813.46279805753;36308;36857.81571092128;37144.25711485809;37260.81369593135;28931.421371572873;29345.70654293515;29422.264443389085;29491.401756130854;29914.252143696584 11:24:10 INFO - PROCESS | 23734 | |2;jquery.html;428.59925969218784;431.7238537241088;441.7128866236946;443.0474479868285;445.17420185555795;18820.811791882075;18948;19537.21851125955;19936.70094948577;19975.700364494507;19117.61764764704;19476.967609921638;19821.405357839252;19822;20749.377518674428;5333.54664853487;5546.112621980484;5548.833534993957;5549.889002219953;5551.639143455683;5460.235567020621;5471;5495.862603434906;5545.889082218353;5601.719914004304;5517.862053448655;5540.889182216353;5543.722813859291;5580.135079062731;5595.132754423071;5476.151196564539;5502.339719233698;5508.173773933902;5570.415106413809;5825.126231065332;5671.347795003545;5671.8582035449035;5695.743691533891;5698.715064246771;5704.8859022819315;21031.05360258792;22830.086796528118;23325.18361857344;23346.76653233463;24528.632070518957;2431.7689819467123;2434.245383930987;2518.0934863449143;2542.0340270697016;2606.2832721001687;10566.682999510027;10729.980651838063;11126.721831954266;14476.493322733653;14704;2064.0299059442036;2085.18677715691;2088.592724418739;2097.7902209779054;2126.319577735125;82786;84366.57816710939;85050;85731.5713421435;87464.5626771862;11516.596919107791;11524.539018439169;11655.88344116548;11751.118666100077;11908;16535.6692866142;16654.666906661798;16675.332986680398;16822.327106915833;16868.493945181664;8494.32045436376;8806.735797926072;8840.33697472692;8946.150115739125;9145.72562823103;8997.325200609981;9060.637574497077;9134.771630709285;9166.358354915224;9186.908130918739;5033.697978121324;5065.442801291855;5089.185730283137;5131.640785145004;5140.074786538459;2070.8861012644447;2095.5704080663427;2114.4502429368167;2136.359092272312;2157.2665293800183;937.8874535055837;1063.4044934836515;1064.9893501065046;1074.3929679730927;1118.0440723181725;19056.71414928777;20016.199352025757;20073;20086.38876946017;20207.393778186677;1061.918639466654;1068.625980906692;1074.8065348237392;1098.3025778630627;1115.130198445214;11031.172662050378;11388;11453.942730286462;11489.540418383338;11677.76644467123;477875.83186252235;492038;507380;507706;519212;56223.15665265024;66740;86418.56790716131;95447;99313.50343248382;1059.6066172982503;1077.8329358949375;1083.7561548651647;1113.771676806269;1170.6546568762235;17443.56391090233;17507.03711295891;17761.555961101076;18187.363442279457;18527;37919.62080379161;38921;39012.609873900896;39299;41301.38047929344;58440.123398148215;59967.40032599793;60562.69718651378;60892.39107609045;60911.69544152251;8961.865572016555;9208.815823683623;9209.493477858781;9227.76930576741;9423.199028082416;8510.531920744419;10860.565577377132;12221.450034748279;13497.730045399234;14246.786298205743;12058.457369418222;12131.332776697367;12142.635720928387;12266.693332666755;12449.626511204679;11046.613368532062;11778.882211177779;11955.820662690241;12069.336186509827;12235.510579577074;6493.740250389931;10441.530131143965;10539.841902371318;12394.380280986095;12526;8935.776605584912;9078.45529268246;9377;9576.664816731382;9672.322937394314;9670.371425857578;12077.335746533674;12087.274763514217;12318.630441086423;12374 11:24:10 INFO - PROCESS | 23734 | |3;mootools.html;1525.572839604911;1554.316100915597;1679.4122057279953;1817.7273408988658;1829.8353148216665;7739.4969326993705;8263.793405164874;8502.234798868101;8605.741827745162;8726.825463490733;8583.184597463247;8604.569771511431;8623.568821558913;8640.39517233794;8679.175478329564;2319.8144148468123;2352.5059737455153;2353.7410884802657;2355.9057637694473;2356.0929042318744;2352.1532248390567;2355.3993731598503;2397.8681172535503;2398.0647547456506;2401.579723548372;2387.9641805372935;2391.186996421225;2393.461471168982;2432.1730611592056;2451.4239153798844;2398.4963157736897;2402.0631953538136;2402.4714562796244;2406.3502854229346;2447.486027934136;2384.487335222918;2423.8788060597076;2436.098643501916;2439.329184474284;2450.534398464304;8781.34139939507;8823.514706691129;8823.779405514913;8837.337199710048;8842.425242359226;5458.808941687062;5648.971755141239;5657.462541058593;5659.717014149317;5665.886682266373;3585.8565657373933;3585.9641403585892;3603.279344131184;3689.7048236141045;3698.1863989922176;1118.6532175025686;1152.4353066997112;1163.7032556698073;1178.85853697556;1207.8912897839236;12260.938695306466;12269.631911042683;12393.690157746038;12412.379381031004;12453.1905426147;4816.735079570587;4899.4365647950945;4934.5805606523845;4968.701877887338;5108.463611320833;10597.41714205726;10618.991195836383;10627.14982801374;10665.413402262795;10676.786464270672;5648.6893220872425;5698.145278208219;5701.059325211377;5707.115397113371;5724;4967.081089998362;5065.670731402447;5074.644774865724;5133.922991155136;5209.817656382009;4251.532331443539;4267.210566045292;4337.15425492026;4440.644748420119;4474.239379305526;1345.488714288564;1350.8108864758942;1360.7210521842999;1365.5220672764453;1383.0387880423211;903.0698380667923;968.5738275158908;1025.2259544044198;1033.5917312661456;1051.4217180550665;5961.463468287875;5991.310999235144;6000.7899723510345;6006.63960162383;6016.69916504173;489.8334566247493;490.1789502583159;491.36123040047795;496.9031038947443;496.91304021796043;4041.555428902818;4160.043190066302;4187.874363769091;4189.476315460567;4222.978885105616;10701.197410194267;10900.236983411085;10950.39772812503;11045.723856903482;11082.113430925507;10065.949670251748;10317.48412579368;10810.62162824313;10861.565537378416;10877.456127193609;8133.837323253501;8162.102168761431;8164.265216130458;8170.509769413854;8224.588770561328;5955;6139.259792094406;6182.69086545662;6234.9688251558455;6285;9615.807683846424;9684.08001239881;9721.027897210222;9742.9025709742;9777.853332200166;9574.329796914428;9912;9950.55222515003;9957.203423726229;10029.197664186993;7511.32398084175;7718.382529397747;7721.150673426031;7825.569593672402;7972.481788683717;8129.349652027942;8163.918360816316;8178.46839955401;8205.425620206528;8251.051129120227;7199.820004499929;7344.816379590553;7402.629868506661;7535.585542795199;7644.312011918954;7048.224695283412;7093.787186384417;7100.254473280231;7176.641167941686;7234.095738032746;6867.416269617139;7060.964695176696;7068.505204635626;7069.081019467436;7083.150021997393;5021.372328458942;5181.792728290977;5234.398044224963;5268.727982788677;5324.6006549508165;5405.648632838853;5440.80302333486;5447.591430642638;5458.781648734006;5536.972315138399 11:24:10 INFO - PROCESS | 23734 | |4;prototype.html;350.9684128428441;354.64004035903565;355.15650330465144;355.7065421027652;359.04852141824165;6692.531522793406;6705.698243579039;6830.590164590116;6850.76022339217;6871.3815756581835;6652.634105124216;6712.261651218374;6727.461803055756;6735.966320168404;6755.054292399068;4872.439669438025;5042.042012017714;5044.596432285427;5047.116754567955;5051.6716413433005;4977.07924034053;4981.651284410093;4981.850544483653;4982.330919142092;4991.575716064139;4905.411350637928;4926.605871530269;4985.127602669537;5011.198208286675;5026.924596131061;4974.10466116099;4983.426905905831;4984.501549845023;4988.251762235675;4989.950100498985;4271.402003719481;4296.548862369469;4308.375285583573;4314.417553630251;4325.091730736549;6432.421082102586;6434.388733070351;6438.7102580384;6445.709943052574;6449.3873082057125;5665.518430933375;5795.884082318372;5840.182374467578;5849.85375365615;5866.794662186846;6965.05971693825;6998.790036298919;7043.753468628624;7064.540804847668;7071.222165561784;4768.094062128184;4768.976155119237;4774.976125119387;4781.545753153445;4790.449098353699;7362.079740032496;7435.814104647373;7442.47902646815;7443;7443.106827180719;4728.976355118271;4907.386576677915;4909.7790599423115;4912.828051018198;4921.901561968741;4831.444383895827;4853.369062021915;4884.072026314989;4884.194107972145;4889.217725163957;5680.11958146488;5688.744006519716;5705.486506214377;5742;5776.364599894008;7094.148702155671;7096.574205547684;7096.645167741593;7103.112110986127;7105.538140020882;1718.4758648612044;1745.4327343613377;1750.7023805953017;1750.824917508239;1754.1580041580114;1106.1703722208345;1129.4973736687095;1134.0870599167583;1138.59579849154;1142.5544037825255;6858.177018757781;6878.312168783182;6885.862282754417;6894.517383783087;6908.240093589701;7310.342069213796;7328.963355183297;7354.595497247596;7356.719416980646;7362.8527429451115;6785.728570857111;6868.896966545506;6893.448524118058;6983.685734141975;6990.6155161465595;3986.7807270600397;4012.1574469361176;4016.5380981186954;4019.41718450823;4020.175863947942;7712.575808330484;7737.187595302525;7738.148803631596;7749.573773442515;7759.456838021397;7487.962560187164;7515.774526764097;7535.585542795199;7554.244575542401;7562.659680314399;7440.702371905171;7656.425768067417;7667.118281397599;7728.26581474759;7735.458517903693;7272.636368181676;7294.598797066213;7325.743598974011;7379.631018449163;7446.367058800062;7310.378617817332;7316.378107860892;7319.963400183178;7328.5969271690565;7346.081739782528;7610.543367397974;7727.0727512696585;7749.186335434698;7761.805954850948;7778.49439786412;4987.7530617345665;5101.234814777813;5125.487451254845;5127.615428842926;5129.615278854176;7300.23347548521;7353.558786472829;7356.595387253752;7356.668949897375;7367.594782286811;7076.398506127037;7099.467539934629;7099.929000709927;7103.573785572882;7113.75101871432;6903.75836845708;7086.610236437045;7091.574505529685;7095.042169307284;7098.964505177441;6988.05661235747;6995.125609298838;6998.160220773336;6999.860002800017;7018.613976231356;7140.178879428932;7154.928450715426;7174.820629484305;7177.318154775288;7179;6958.304169583002;6997.370236678723;7000.089988301488;7010.193827709879;7012.4390048796995 11:24:10 INFO - PROCESS | 23734 | |5;yui.html;916.1754421021076;925.4493576322086;925.8564922437023;926.7127190570924;941.2046820436728;14412.783808242872;14520.709585808278;14525;15783.447579334726;15904;15624.21878906053;15655.765163522556;15717.92141039296;15777.447789327376;15805.920970395133;916.9266458683322;921;924.8843894513186;927.3693888156051;929.707142250189;894.4186278918689;932.1889955738517;939.2204470289678;939.7086903060039;939.8355287824637;973.3624475968252;975.6731494949165;976.6776963601994;978.9657361992332;980.7793246519548;967.7338731848763;971.5725080964388;972.9318947673665;974.055166488505;975.3172779054655;696.4080531548194;698.9370956613878;708.9468289878229;714.2678754276908;714.5319815520842;14487.348069336906;14522.564323070324;14541.054831435922;14559.927200364036;14624.122552646875;13737.175769453765;13875.930620346935;14502.347394367172;14599.854001459955;14625.707485850224;11333.773324533464;11609.883901161049;11768.529258829636;11955.342456164908;11994.16040877139;4505.684602077856;4560.863174104782;4618.56123668251;4679.251319788817;4728.196206644879;56509.43490565083;57286;57373.713131434495;57655.71172144154;58288.70855645695;11301.943490282496;11314;11319.264247823865;11555.711107222218;11703.122265829927;20569.280075197297;20642.690359644617;20653.690194647093;20668.48328791762;20678.069486873126;8203.83592328162;8270.751877443687;8329.750107496784;8355.456895301908;8631.956840215758;4952.975235123801;4965.155923493015;5035.169197082514;5094.465081166424;5210.296609957683;3514.8066856322635;3547.8048707321345;3570.250247448013;3570.571531416195;3572.1248294168095;646.7833275852643;647.2847503508649;647.7700416352127;669.8024082895557;671.7514519627769;678.6878036103448;788.6175205025557;790.4269404681675;813.5606772342987;824.6866190847439;9540.284478664127;9859.50702464874;10077.294589378673;10091.7477063074;10118.291719579558;652.1749986267375;798.7483942558192;807.8707406814881;814.8329592433537;817.7260617693021;4427.889302767392;4477.664175186809;4481.058977614737;4514.503404625489;4515.435570553681;66134.33865661378;66929.66535167293;67081.66459167673;67242;67688;57570.42429575651;58013.709931450074;59156.40843591595;59185;59321;51524.742376287875;51592.74203629033;51624;52938.47061529335;53198.20202696963;8621.741347759576;8721.127887211229;8817.382783205114;8906.109389061043;9021.32340074484;38606;38889.22221555497;39728.80135599419;39995.600043999184;40336.59663403328;45902;46232.76883615561;51276.23085653644;51547.48452515427;52023.47976520186;10656.413897235416;10755.516001779783;10885.945570272099;11049.72375690582;11148.665540033811;12859.485620575073;13117.868821312046;13155.934220328838;13191;13214.735705286033;12266.386680665753;12269.263844169378;12348.073894457772;12491.625251242478;12590.685232868886;11107.888921110685;11165;11259.437028148395;11283.887161128612;11384.658460246206;12398.380080996094;12553.811692824798;12800.16798908068;13379.933100334436;13497.122687025312;10988.230823842574;11008.834867477155;11011.174161937726;11032.834507482234;11223.158263130135;10598.735031624272;11224.55101795919;11342.489587968395;11537.134714896249;11597.6520704379 11:24:10 INFO - PROCESS | 23734 | __end_tp_report 11:24:10 INFO - PROCESS | 23734 | __start_cc_report 11:24:10 INFO - PROCESS | 23734 | _x_x_mozilla_cycle_collect,337 11:24:10 INFO - PROCESS | 23734 | __end_cc_report 11:24:10 INFO - PROCESS | 23734 | __startTimestamp1466015050075__endTimestamp 11:24:10 INFO - PROCESS | 23734 | 11:24:10 INFO - PROCESS | 23734 | ------- Summary: start ------- 11:24:10 INFO - PROCESS | 23734 | Number of tests: 6 11:24:10 INFO - PROCESS | 23734 | 11:24:10 INFO - PROCESS | 23734 | [#0] dojo.html Cycles:165 Average:5674.87 Median:5928.67 stddev:638.01 (10.8%) stddev-sans-first:614.28 11:24:10 INFO - PROCESS | 23734 | Values: 3390.8 3427.7 3432.1 3446.5 3461.6 5680.6 5698.8 5717.8 5723.8 5724.7 5693.3 5704.5 5725.6 5736.8 5745.1 5138.6 5173.5 5189.9 5233.1 5254.0 5189.5 5218.9 5227.0 5248.6 5277.5 5173.9 5214.2 5231.8 5236.2 5277.3 5240.1 5249.7 5261.8 5265.2 5301.8 5076.4 5084.1 5096.6 5158.1 5164.7 5487.9 5496.9 5501.2 5507.2 5548.0 5966.5 6000.3 6013.2 6021.8 6022.2 6006.3 6061.3 6065.3 6115.7 6185.5 5778.9 5781.5 5782.2 5784.9 5786.9 6296.0 6313.8 6315.0 6317.0 6319.4 6023.0 6034.0 6039.6 6099.5 6108.8 6053.7 6101.0 6106.2 6168.2 6178.4 5928.9 5951.9 6083.4 6122.8 6131.5 6022.8 6072.6 6077.7 6092.8 6104.1 4593.5 4594.5 4595.3 4599.4 4620.3 4074.4 4074.6 4113.6 4124.4 4139.6 5748.5 5750.8 5773.9 5808.2 5890.4 6117.5 6128.4 6201.7 6207.2 6235.7 5766.0 5831.3 5838.3 5841.9 5891.7 5250.4 5268.7 5273.4 5314.9 5317.7 6380.3 6389.8 6400.0 6408.7 6411.7 6060.7 6130.4 6183.0 6216.9 6222.8 6284.9 6289.0 6292.2 6294.1 6294.7 5951.3 5955.8 5960.5 5974.7 5995.7 5977.2 6000.4 6063.6 6104.5 6116.3 5893.4 5928.7 5943.8 5961.6 5991.6 5923.1 5946.5 5947.6 5951.5 5954.1 5768.9 5836.1 5874.5 5911.3 5970.5 5977.7 6001.3 6020.8 6037.0 6048.2 5916.8 5929.1 5933.6 5934.7 5938.0 11:24:10 INFO - PROCESS | 23734 | 11:24:10 INFO - PROCESS | 23734 | [#1] ext.html Cycles:180 Average:57245.03 Median:41538.98 stddev:109845.42 (264.4%) stddev-sans-first:110071.23 11:24:10 INFO - PROCESS | 23734 | Values: 599.5 648.4 653.3 666.2 674.8 33349.5 34114.7 40575.4 41395.6 41682.4 43273.0 43749.8 43842.3 43871.3 43924.3 8783.4 8918.2 8920.7 8921.4 8960.1 8801.6 8881.5 8884.7 8889.5 8935.9 9149.2 9193.5 9198.9 9201.8 9242.1 9095.5 9123.5 9183.2 9212.6 9250.6 8981.5 9103.3 9111.7 9126.1 9144.1 43750.3 44139.3 44252.3 44359.1 44422.1 3693.4 3749.5 3799.8 4234.6 4312.2 33346.5 34124.3 34293.0 34315.8 35487.5 4580.0 4592.5 4641.2 4664.7 4701.6 317785.0 320109.0 322296.0 322500.0 323292.0 39526.0 60522.4 61037.7 61127.7 61192.0 37961.8 38037.5 38207.0 38213.2 38274.0 16441.9 16490.2 16600.1 16605.9 16690.8 15232.8 15340.0 15353.2 15377.4 15379.8 9502.7 9531.3 9542.7 9566.5 9595.8 3589.9 3599.7 3606.9 3670.5 3679.2 1066.8 1086.9 1144.9 1204.1 1239.3 33262.5 33385.7 33428.8 33744.8 33863.8 1163.5 1245.8 1266.7 1283.5 1305.9 17520.2 17588.9 17691.0 17742.8 17810.5 471793.0 525180.0 532126.0 537545.0 540825.0 63557.7 64427.4 64748.7 64791.7 64923.0 1501.5 1506.5 1507.1 1518.7 1524.8 33196.0 33406.7 33887.7 34106.1 34184.5 55583.4 56048.4 56063.2 56237.7 56567.7 373021.0 374663.0 375158.0 375165.0 376934.0 31101.7 47462.3 47775.3 47800.8 47910.8 44921.0 44978.1 45194.0 45670.0 45859.5 37740.2 38256.4 38336.8 39522.0 40397.2 38832.6 40821.2 41702.8 41977.8 41997.6 42763.6 42865.4 43105.4 43268.8 43436.6 35813.5 36308.0 36857.8 37144.3 37260.8 28931.4 29345.7 29422.3 29491.4 29914.3 11:24:10 INFO - PROCESS | 23734 | 11:24:10 INFO - PROCESS | 23734 | [#2] jquery.html Cycles:180 Average:29339.59 Median:2433.01 stddev:82423.94 (3387.7%) stddev-sans-first:82626.58 11:24:10 INFO - PROCESS | 23734 | Values: 428.6 431.7 441.7 443.0 445.2 18820.8 18948.0 19537.2 19936.7 19975.7 19117.6 19477.0 19821.4 19822.0 20749.4 5333.5 5546.1 5548.8 5549.9 5551.6 5460.2 5471.0 5495.9 5545.9 5601.7 5517.9 5540.9 5543.7 5580.1 5595.1 5476.2 5502.3 5508.2 5570.4 5825.1 5671.3 5671.9 5695.7 5698.7 5704.9 21031.1 22830.1 23325.2 23346.8 24528.6 2431.8 2434.2 2518.1 2542.0 2606.3 10566.7 10730.0 11126.7 14476.5 14704.0 2064.0 2085.2 2088.6 2097.8 2126.3 82786.0 84366.6 85050.0 85731.6 87464.6 11516.6 11524.5 11655.9 11751.1 11908.0 16535.7 16654.7 16675.3 16822.3 16868.5 8494.3 8806.7 8840.3 8946.2 9145.7 8997.3 9060.6 9134.8 9166.4 9186.9 5033.7 5065.4 5089.2 5131.6 5140.1 2070.9 2095.6 2114.5 2136.4 2157.3 937.9 1063.4 1065.0 1074.4 1118.0 19056.7 20016.2 20073.0 20086.4 20207.4 1061.9 1068.6 1074.8 1098.3 1115.1 11031.2 11388.0 11453.9 11489.5 11677.8 477875.8 492038.0 507380.0 507706.0 519212.0 56223.2 66740.0 86418.6 95447.0 99313.5 1059.6 1077.8 1083.8 1113.8 1170.7 17443.6 17507.0 17761.6 18187.4 18527.0 37919.6 38921.0 39012.6 39299.0 41301.4 58440.1 59967.4 60562.7 60892.4 60911.7 8961.9 9208.8 9209.5 9227.8 9423.2 8510.5 10860.6 12221.5 13497.7 14246.8 12058.5 12131.3 12142.6 12266.7 12449.6 11046.6 11778.9 11955.8 12069.3 12235.5 6493.7 10441.5 10539.8 12394.4 12526.0 8935.8 9078.5 9377.0 9576.7 9672.3 9670.4 12077.3 12087.3 12318.6 12374.0 11:24:10 INFO - PROCESS | 23734 | 11:24:10 INFO - PROCESS | 23734 | [#3] mootools.html Cycles:180 Average:5822.46 Median:5070.16 stddev:3221.60 (63.5%) stddev-sans-first:3214.46 11:24:10 INFO - PROCESS | 23734 | Values: 1525.6 1554.3 1679.4 1817.7 1829.8 7739.5 8263.8 8502.2 8605.7 8726.8 8583.2 8604.6 8623.6 8640.4 8679.2 2319.8 2352.5 2353.7 2355.9 2356.1 2352.2 2355.4 2397.9 2398.1 2401.6 2388.0 2391.2 2393.5 2432.2 2451.4 2398.5 2402.1 2402.5 2406.4 2447.5 2384.5 2423.9 2436.1 2439.3 2450.5 8781.3 8823.5 8823.8 8837.3 8842.4 5458.8 5649.0 5657.5 5659.7 5665.9 3585.9 3586.0 3603.3 3689.7 3698.2 1118.7 1152.4 1163.7 1178.9 1207.9 12260.9 12269.6 12393.7 12412.4 12453.2 4816.7 4899.4 4934.6 4968.7 5108.5 10597.4 10619.0 10627.1 10665.4 10676.8 5648.7 5698.1 5701.1 5707.1 5724.0 4967.1 5065.7 5074.6 5133.9 5209.8 4251.5 4267.2 4337.2 4440.6 4474.2 1345.5 1350.8 1360.7 1365.5 1383.0 903.1 968.6 1025.2 1033.6 1051.4 5961.5 5991.3 6000.8 6006.6 6016.7 489.8 490.2 491.4 496.9 496.9 4041.6 4160.0 4187.9 4189.5 4223.0 10701.2 10900.2 10950.4 11045.7 11082.1 10065.9 10317.5 10810.6 10861.6 10877.5 8133.8 8162.1 8164.3 8170.5 8224.6 5955.0 6139.3 6182.7 6235.0 6285.0 9615.8 9684.1 9721.0 9742.9 9777.9 9574.3 9912.0 9950.6 9957.2 10029.2 7511.3 7718.4 7721.2 7825.6 7972.5 8129.3 8163.9 8178.5 8205.4 8251.1 7199.8 7344.8 7402.6 7535.6 7644.3 7048.2 7093.8 7100.3 7176.6 7234.1 6867.4 7061.0 7068.5 7069.1 7083.2 5021.4 5181.8 5234.4 5268.7 5324.6 5405.6 5440.8 5447.6 5458.8 5537.0 11:24:10 INFO - PROCESS | 23734 | 11:24:10 INFO - PROCESS | 23734 | [#4] prototype.html Cycles:180 Average:5923.18 Median:6863.54 stddev:1835.38 (26.7%) stddev-sans-first:1792.24 11:24:10 INFO - PROCESS | 23734 | Values: 351.0 354.6 355.2 355.7 359.0 6692.5 6705.7 6830.6 6850.8 6871.4 6652.6 6712.3 6727.5 6736.0 6755.1 4872.4 5042.0 5044.6 5047.1 5051.7 4977.1 4981.7 4981.9 4982.3 4991.6 4905.4 4926.6 4985.1 5011.2 5026.9 4974.1 4983.4 4984.5 4988.3 4990.0 4271.4 4296.5 4308.4 4314.4 4325.1 6432.4 6434.4 6438.7 6445.7 6449.4 5665.5 5795.9 5840.2 5849.9 5866.8 6965.1 6998.8 7043.8 7064.5 7071.2 4768.1 4769.0 4775.0 4781.5 4790.4 7362.1 7435.8 7442.5 7443.0 7443.1 4729.0 4907.4 4909.8 4912.8 4921.9 4831.4 4853.4 4884.1 4884.2 4889.2 5680.1 5688.7 5705.5 5742.0 5776.4 7094.1 7096.6 7096.6 7103.1 7105.5 1718.5 1745.4 1750.7 1750.8 1754.2 1106.2 1129.5 1134.1 1138.6 1142.6 6858.2 6878.3 6885.9 6894.5 6908.2 7310.3 7329.0 7354.6 7356.7 7362.9 6785.7 6868.9 6893.4 6983.7 6990.6 3986.8 4012.2 4016.5 4019.4 4020.2 7712.6 7737.2 7738.1 7749.6 7759.5 7488.0 7515.8 7535.6 7554.2 7562.7 7440.7 7656.4 7667.1 7728.3 7735.5 7272.6 7294.6 7325.7 7379.6 7446.4 7310.4 7316.4 7320.0 7328.6 7346.1 7610.5 7727.1 7749.2 7761.8 7778.5 4987.8 5101.2 5125.5 5127.6 5129.6 7300.2 7353.6 7356.6 7356.7 7367.6 7076.4 7099.5 7099.9 7103.6 7113.8 6903.8 7086.6 7091.6 7095.0 7099.0 6988.1 6995.1 6998.2 6999.9 7018.6 7140.2 7154.9 7174.8 7177.3 7179.0 6958.3 6997.4 7000.1 7010.2 7012.4 11:24:10 INFO - PROCESS | 23734 | 11:24:10 INFO - PROCESS | 23734 | [#5] yui.html Cycles:180 Average:15636.00 Median:25260.28 stddev:18356.11 (72.7%) stddev-sans-first:18374.32 11:24:10 INFO - PROCESS | 23734 | Values: 916.2 925.4 925.9 926.7 941.2 14412.8 14520.7 14525.0 15783.4 15904.0 15624.2 15655.8 15717.9 15777.4 15805.9 916.9 921.0 924.9 927.4 929.7 894.4 932.2 939.2 939.7 939.8 973.4 975.7 976.7 979.0 980.8 967.7 971.6 972.9 974.1 975.3 696.4 698.9 708.9 714.3 714.5 14487.3 14522.6 14541.1 14559.9 14624.1 13737.2 13875.9 14502.3 14599.9 14625.7 11333.8 11609.9 11768.5 11955.3 11994.2 4505.7 4560.9 4618.6 4679.3 4728.2 56509.4 57286.0 57373.7 57655.7 58288.7 11301.9 11314.0 11319.3 11555.7 11703.1 20569.3 20642.7 20653.7 20668.5 20678.1 8203.8 8270.8 8329.8 8355.5 8632.0 4953.0 4965.2 5035.2 5094.5 5210.3 3514.8 3547.8 3570.3 3570.6 3572.1 646.8 647.3 647.8 669.8 671.8 678.7 788.6 790.4 813.6 824.7 9540.3 9859.5 10077.3 10091.7 10118.3 652.2 798.7 807.9 814.8 817.7 4427.9 4477.7 4481.1 4514.5 4515.4 66134.3 66929.7 67081.7 67242.0 67688.0 57570.4 58013.7 59156.4 59185.0 59321.0 51524.7 51592.7 51624.0 52938.5 53198.2 8621.7 8721.1 8817.4 8906.1 9021.3 38606.0 38889.2 39728.8 39995.6 40336.6 45902.0 46232.8 51276.2 51547.5 52023.5 10656.4 10755.5 10885.9 11049.7 11148.7 12859.5 13117.9 13155.9 13191.0 13214.7 12266.4 12269.3 12348.1 12491.6 12590.7 11107.9 11165.0 11259.4 11283.9 11384.7 12398.4 12553.8 12800.2 13379.9 13497.1 10988.2 11008.8 11011.2 11032.8 11223.2 10598.7 11224.6 11342.5 11537.1 11597.7 11:24:10 INFO - PROCESS | 23734 | -------- Summary: end -------- 11:24:10 INFO - PROCESS | 23734 | 11:24:10 INFO - TEST-INFO | 23734: exit 0 11:24:10 INFO - TEST-OK | dromaeo_css | took 1108862ms 11:24:10 INFO - TEST-START | kraken 11:24:10 INFO - operating with platform_type : linux_ 11:24:10 INFO - Initialising browser for kraken test... 11:24:10 INFO - TEST-INFO | started process 23979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvNfOB3/profile http://localhost:49280/getInfo.html) 11:24:14 INFO - PROCESS | 23979 | 11:24:14 INFO - PROCESS | 23979 | (process:24056): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:24:15 INFO - PROCESS | 23979 | __metrics Screen width/height:1600/1200 11:24:15 INFO - PROCESS | 23979 | colorDepth:24 11:24:15 INFO - PROCESS | 23979 | Browser inner width/height: 1024/697 11:24:15 INFO - PROCESS | 23979 | __metrics 11:24:16 ERROR - PROCESS | 23979 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 11:24:16 INFO - TEST-INFO | 23979: exit 0 11:24:16 INFO - Browser initialized. 11:24:16 INFO - Running cycle 1/1 for kraken test... 11:24:16 INFO - TEST-INFO | started process 24106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvNfOB3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:24:18 INFO - PROCESS | 24106 | 11:24:18 INFO - PROCESS | 24106 | (process:24174): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:24:28 INFO - PROCESS | 24106 | RSS: Main: 150921216 11:24:28 INFO - PROCESS | 24106 | 11:24:31 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 11:24:32 INFO - PROCESS | 24106 | RSS: Main: 156479488 11:24:32 INFO - PROCESS | 24106 | 11:24:34 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 11:24:35 INFO - PROCESS | 24106 | RSS: Main: 156491776 11:24:35 INFO - PROCESS | 24106 | 11:24:38 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 11:24:38 INFO - PROCESS | 24106 | RSS: Main: 156672000 11:24:38 INFO - PROCESS | 24106 | 11:24:40 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 11:24:41 INFO - PROCESS | 24106 | RSS: Main: 156577792 11:24:41 INFO - PROCESS | 24106 | 11:24:43 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:24:44 INFO - PROCESS | 24106 | RSS: Main: 156401664 11:24:44 INFO - PROCESS | 24106 | 11:24:47 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 11:24:47 INFO - PROCESS | 24106 | RSS: Main: 157114368 11:24:47 INFO - PROCESS | 24106 | 11:24:51 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 11:24:51 INFO - PROCESS | 24106 | RSS: Main: 157077504 11:24:51 INFO - PROCESS | 24106 | 11:24:54 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 11:24:55 INFO - PROCESS | 24106 | RSS: Main: 156737536 11:24:55 INFO - PROCESS | 24106 | 11:24:56 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:24:57 INFO - PROCESS | 24106 | RSS: Main: 156409856 11:24:57 INFO - PROCESS | 24106 | 11:24:59 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:24:59 INFO - PROCESS | 24106 | RSS: Main: 156610560 11:24:59 INFO - PROCESS | 24106 | 11:25:01 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:25:02 INFO - PROCESS | 24106 | RSS: Main: 157036544 11:25:02 INFO - PROCESS | 24106 | 11:25:04 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:25:05 INFO - PROCESS | 24106 | RSS: Main: 157597696 11:25:05 INFO - PROCESS | 24106 | 11:25:08 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:08 INFO - PROCESS | 24106 | RSS: Main: 157151232 11:25:08 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 11:25:10 INFO - PROCESS | 24106 | RSS: Main: 158576640 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | __start_tp_report 11:25:10 INFO - PROCESS | 24106 | _x_x_mozilla_page_load 11:25:10 INFO - PROCESS | 24106 | _x_x_mozilla_page_load_details 11:25:10 INFO - PROCESS | 24106 | |i|pagename|runs| 11:25:10 INFO - PROCESS | 24106 | |0;ai-astar;107;113;103;111;118;113;100;112;111;110 11:25:10 INFO - PROCESS | 24106 | |1;audio-beat-detection;160;126;150;185;128;159;158;133;179;126 11:25:10 INFO - PROCESS | 24106 | |2;audio-dft;162;164;163;162;163;164;164;163;163;163 11:25:10 INFO - PROCESS | 24106 | |3;audio-fft;74;77;78;181;76;76;76;74;173;74 11:25:10 INFO - PROCESS | 24106 | |4;audio-oscillator;92;92;146;92;92;92;145;91;91;146 11:25:10 INFO - PROCESS | 24106 | |5;imaging-gaussian-blur;117;117;117;119;117;117;118;118;116;118 11:25:10 INFO - PROCESS | 24106 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;146;150 11:25:10 INFO - PROCESS | 24106 | |7;imaging-desaturate;99;95;96;95;95;95;94;95;95;96 11:25:10 INFO - PROCESS | 24106 | |8;json-parse-financial;54;55;58;54;55;56;60;79;66;54 11:25:10 INFO - PROCESS | 24106 | |9;json-stringify-tinderbox;59;62;58;57;58;57;60;58;58;58 11:25:10 INFO - PROCESS | 24106 | |10;stanford-crypto-aes;73;73;74;74;74;75;75;74;74;74 11:25:10 INFO - PROCESS | 24106 | |11;stanford-crypto-ccm;116;127;124;117;118;123;112;117;133;145 11:25:10 INFO - PROCESS | 24106 | |12;stanford-crypto-pbkdf2;160;158;159;166;159;156;157;163;164;156 11:25:10 INFO - PROCESS | 24106 | |13;stanford-crypto-sha256-iterative;66;67;65;65;76;69;66;66;67;65 11:25:10 INFO - PROCESS | 24106 | __end_tp_report 11:25:10 INFO - PROCESS | 24106 | __start_cc_report 11:25:10 INFO - PROCESS | 24106 | _x_x_mozilla_cycle_collect,854 11:25:10 INFO - PROCESS | 24106 | __end_cc_report 11:25:10 INFO - PROCESS | 24106 | __startTimestamp1466015110750__endTimestamp 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | ------- Summary: start ------- 11:25:10 INFO - PROCESS | 24106 | Number of tests: 14 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.50 stddev:5.22 (4.7%) stddev-sans-first:5.44 11:25:10 INFO - PROCESS | 24106 | Values: 107.0 113.0 103.0 111.0 118.0 113.0 100.0 112.0 111.0 110.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:158.50 stddev:21.69 (13.7%) stddev-sans-first:22.73 11:25:10 INFO - PROCESS | 24106 | Values: 160.0 126.0 150.0 185.0 128.0 159.0 158.0 133.0 179.0 126.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 11:25:10 INFO - PROCESS | 24106 | Values: 162.0 164.0 163.0 162.0 163.0 164.0 164.0 163.0 163.0 163.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#3] audio-fft Cycles:10 Average:95.90 Median:76.00 stddev:42.81 (56.3%) stddev-sans-first:44.66 11:25:10 INFO - PROCESS | 24106 | Values: 74.0 77.0 78.0 181.0 76.0 76.0 76.0 74.0 173.0 74.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#4] audio-oscillator Cycles:10 Average:107.90 Median:92.00 stddev:26.07 (28.3%) stddev-sans-first:27.00 11:25:10 INFO - PROCESS | 24106 | Values: 92.0 92.0 146.0 92.0 92.0 92.0 145.0 91.0 91.0 146.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 11:25:10 INFO - PROCESS | 24106 | Values: 117.0 117.0 117.0 119.0 117.0 117.0 118.0 118.0 116.0 118.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.00 stddev:1.27 (0.9%) stddev-sans-first:1.33 11:25:10 INFO - PROCESS | 24106 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 150.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.35 (1.4%) stddev-sans-first:0.60 11:25:10 INFO - PROCESS | 24106 | Values: 99.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:57.00 stddev:7.94 (13.9%) stddev-sans-first:8.20 11:25:10 INFO - PROCESS | 24106 | Values: 54.0 55.0 58.0 54.0 55.0 56.0 60.0 79.0 66.0 54.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.00 stddev:1.51 (2.6%) stddev-sans-first:1.59 11:25:10 INFO - PROCESS | 24106 | Values: 59.0 62.0 58.0 57.0 58.0 57.0 60.0 58.0 58.0 58.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:74.00 stddev:0.67 (0.9%) stddev-sans-first:0.60 11:25:10 INFO - PROCESS | 24106 | Values: 73.0 73.0 74.0 74.0 74.0 75.0 75.0 74.0 74.0 74.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:123.50 stddev:9.82 (8.0%) stddev-sans-first:10.06 11:25:10 INFO - PROCESS | 24106 | Values: 116.0 127.0 124.0 117.0 118.0 123.0 112.0 117.0 133.0 145.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:159.50 stddev:3.46 (2.2%) stddev-sans-first:3.67 11:25:10 INFO - PROCESS | 24106 | Values: 160.0 158.0 159.0 166.0 159.0 156.0 157.0 163.0 164.0 156.0 11:25:10 INFO - PROCESS | 24106 | 11:25:10 INFO - PROCESS | 24106 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:66.50 stddev:3.33 (5.0%) stddev-sans-first:3.50 11:25:10 INFO - PROCESS | 24106 | Values: 66.0 67.0 65.0 65.0 76.0 69.0 66.0 66.0 67.0 65.0 11:25:10 INFO - PROCESS | 24106 | -------- Summary: end -------- 11:25:10 INFO - PROCESS | 24106 | 11:25:11 INFO - TEST-INFO | 24106: exit 0 11:25:11 INFO - TEST-OK | kraken | took 60968ms 11:25:11 INFO - SUITE-END | took 1169s 11:25:11 INFO - Completed test suite (00:19:29) 11:25:11 INFO - javascript benchmark 11:25:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3390.762646614737, 3427.6572342765744, 3432.1076520104766, 3446.46579780134, 3461.567304086989, 5680.573956953224, 5698.8005419810315, 5717.828465146053, 5723.771049158028, 5724.713764311783, 5693.316801983768, 5704.515116215116, 5725.57058220633, 5736.827895163141, 5745.138229265613, 5138.5889128869785, 5173.482651734834, 5189.922151167735, 5233.058049551079, 5254.028004819102, 5189.506996835295, 5218.947810521903, 5227.032998895197, 5248.5538729208065, 5277.472252774711, 5173.9482605174035, 5214.243934629495, 5231.79072837088, 5236.188390799432, 5277.340332458442, 5240.082985477527, 5249.658772179796, 5261.789528418859, 5265.183896496049, 5301.840944771663, 5076.390833100015, 5084.084864724348, 5096.566791822663, 5158.148905430599, 5164.690118592896, 5487.890242195133, 5496.890062198733, 5501.174823776466, 5507.228987941691, 5548.029094908375, 5966.481447396535, 6000.309964354068, 6013.15815785786, 6021.849453763647, 6022.156898034279, 6006.309274433409, 6061.272647282354, 6065.302490213638, 6115.727150604481, 6185.474234690057, 5778.88442231153, 5781.508571771405, 5782.190493330895, 5784.942150578482, 5786.88426231473, 6296.0, 6313.810585682437, 6315.0, 6317.0, 6319.399657032574, 6022.969885150546, 6033.9698301508215, 6039.607425517327, 6099.542534309944, 6108.816735497942, 6053.727582258721, 6101.0, 6106.2061931948565, 6168.228971378578, 6178.351273116348, 5928.940710592925, 5951.851203719942, 6083.422074902877, 6122.7550897964475, 6131.509479241739, 6022.759089636365, 6072.635641861502, 6077.726502307407, 6092.7562897484495, 6104.11490333908, 4593.494715581283, 4594.494605593382, 4595.287730401793, 4599.448066232007, 4620.283856002325, 4074.4295798587627, 4074.5517993020744, 4113.568075352105, 4124.4019617155345, 4139.648129908992, 5748.45389687979, 5750.769969201268, 5773.91339129905, 5808.186853840466, 5890.3815099414805, 6117.480014198754, 6128.448439640454, 6201.658908760061, 6207.224096987877, 6235.719392627343, 5766.0, 5831.329397119301, 5838.2702162229725, 5841.912371314434, 5891.734871930774, 5250.369955605275, 5268.710220937808, 5273.446288139767, 5314.92027619586, 5317.707526086025, 6380.298167201604, 6389.808305750835, 6400.0, 6408.743650254031, 6411.743530258737, 6060.666663333559, 6130.417610327012, 6183.0, 6216.906746398718, 6222.81331560054, 6284.937150628618, 6289.0, 6292.1505596743855, 6294.118823364641, 6294.685265736786, 5951.256092988377, 5955.76176952917, 5960.4635582797755, 5974.701264936823, 5995.700214989146, 5977.163197152489, 6000.429959153874, 6063.636181829104, 6104.4505994460715, 6116.33577150815, 5893.44012318829, 5928.67392293428, 5943.791967281298, 5961.552883533839, 5991.610545314541, 5923.08192230205, 5946.524278057658, 5947.6431414115295, 5951.494122999594, 5954.10688396744, 5768.913466298093, 5836.124581312837, 5874.500667443144, 5911.290645122441, 5970.462658360769, 5977.7310021050025, 6001.339852616122, 6020.759169633166, 6037.0, 6048.183495228088, 5916.822495325147, 5929.0513517836935, 5933.6439813609595, 5934.732937017931, 5938.0], "value": 5632.722468324565, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.5143933413935, 648.4131860666093, 653.3303364051847, 666.2371584535707, 674.8110529051864, 33349.499757503625, 34114.658853411456, 40575.39136912949, 41395.58604413955, 41682.37476437856, 43273.0, 43749.7812510937, 43842.342364864475, 43871.341929871, 43924.341134883005, 8783.38516303859, 8918.241949434307, 8920.73237802867, 8921.420107693011, 8960.148785865333, 8801.647934082628, 8881.511516866569, 8884.689035883745, 8889.511076890769, 8935.865962010575, 9149.176574108329, 9193.540322983825, 9198.862017069749, 9201.815963680723, 9242.121998410174, 9095.454272743624, 9123.543822808866, 9183.219426348769, 9212.585433655468, 9250.629974801, 8981.461112333216, 9103.31725120612, 9111.681091161778, 9126.13301736334, 9144.131307525775, 43750.343744843856, 44139.337909931375, 44252.3362149568, 44359.112817743466, 44422.111557768985, 3693.372126738434, 3749.531308586427, 3799.7530160539477, 4234.640055595278, 4312.2022425851, 33346.499802502985, 34124.31751364984, 34293.0, 34315.828420857986, 35487.4676879847, 4579.977100114478, 4592.517785632527, 4641.187792136363, 4664.650151238637, 4701.623870090384, 317785.0, 320109.0, 322295.9999999977, 322500.0, 323292.0, 39526.0, 60522.394776052555, 61037.69481152566, 61127.69436152791, 61192.0, 37961.81019094887, 38037.47850086021, 38207.0, 38213.23573528514, 38274.043148920944, 16441.91779041097, 16490.17549122539, 16600.086995215137, 16605.91697041507, 16690.833091668926, 15232.771508427382, 15340.0, 15353.232338383035, 15377.38490460369, 15379.84620153784, 9502.667406640734, 9531.285153613506, 9542.713718588453, 9566.473843938651, 9595.760105997266, 3589.9102522436624, 3599.7120230381506, 3606.945895811565, 3670.522832031872, 3679.1537946272506, 1066.7706443114612, 1086.9184811139196, 1144.9026832719146, 1204.1390405859852, 1239.305988646361, 33262.50106248408, 33385.68900729658, 33428.832855835564, 33744.83127584396, 33863.83068084644, 1163.528770847808, 1245.8131280307846, 1266.66366982834, 1283.4801905228398, 1305.9281739504418, 17520.21159047846, 17588.91205543964, 17691.0, 17742.822571774374, 17810.465686029438, 471793.0, 525180.0, 532126.0, 537545.0, 540825.0, 63557.682211588646, 64427.35572644307, 64748.67625661842, 64791.676041620434, 64923.0, 1501.5495351394538, 1506.5103841251637, 1507.148461119464, 1518.7114448254797, 1524.7865298857946, 33196.0, 33406.665933341326, 33887.661123388454, 34106.1339487764, 34184.48723269103, 55583.44416555783, 56048.439515604325, 56063.15905261506, 56237.718811405684, 56567.71716141393, 373021.0, 374663.0, 375158.0, 375165.0, 376934.0, 31101.688983109878, 47462.288065679735, 47775.28337075016, 47800.7609961948, 47910.76044619754, 44921.0, 44978.100437990404, 45194.0, 45670.0, 45859.54140458553, 37740.2451950965, 38256.426153607164, 38336.80831595824, 39522.0, 40397.1920561593, 38832.6116738829, 40821.1835763289, 41702.79148604359, 41977.790111049246, 41997.580024200586, 42763.572364277206, 42865.35701964411, 43105.35341969936, 43268.78365608152, 43436.56563434325, 35813.46279805753, 36308.0, 36857.81571092128, 37144.25711485809, 37260.81369593135, 28931.421371572873, 29345.70654293515, 29422.264443389085, 29491.401756130854, 29914.252143696584], "value": 19841.315194412116, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.59925969218784, 431.7238537241088, 441.7128866236946, 443.0474479868285, 445.17420185555795, 18820.811791882075, 18948.0, 19537.21851125955, 19936.70094948577, 19975.700364494507, 19117.61764764704, 19476.967609921638, 19821.405357839252, 19822.0, 20749.377518674428, 5333.54664853487, 5546.112621980484, 5548.833534993957, 5549.889002219953, 5551.639143455683, 5460.235567020621, 5471.0, 5495.862603434906, 5545.889082218353, 5601.719914004304, 5517.862053448655, 5540.889182216353, 5543.722813859291, 5580.135079062731, 5595.132754423071, 5476.151196564539, 5502.339719233698, 5508.173773933902, 5570.415106413809, 5825.126231065332, 5671.347795003545, 5671.8582035449035, 5695.743691533891, 5698.715064246771, 5704.8859022819315, 21031.05360258792, 22830.086796528118, 23325.18361857344, 23346.76653233463, 24528.632070518957, 2431.7689819467123, 2434.245383930987, 2518.0934863449143, 2542.0340270697016, 2606.2832721001687, 10566.682999510027, 10729.980651838063, 11126.721831954266, 14476.493322733653, 14704.0, 2064.0299059442036, 2085.18677715691, 2088.592724418739, 2097.7902209779054, 2126.319577735125, 82786.0, 84366.57816710939, 85050.0, 85731.5713421435, 87464.5626771862, 11516.596919107791, 11524.539018439169, 11655.88344116548, 11751.118666100077, 11908.0, 16535.6692866142, 16654.666906661798, 16675.332986680398, 16822.327106915833, 16868.493945181664, 8494.32045436376, 8806.735797926072, 8840.33697472692, 8946.150115739125, 9145.72562823103, 8997.325200609981, 9060.637574497077, 9134.771630709285, 9166.358354915224, 9186.908130918739, 5033.697978121324, 5065.442801291855, 5089.185730283137, 5131.640785145004, 5140.074786538459, 2070.8861012644447, 2095.5704080663427, 2114.4502429368167, 2136.359092272312, 2157.2665293800183, 937.8874535055837, 1063.4044934836515, 1064.9893501065046, 1074.3929679730927, 1118.0440723181725, 19056.71414928777, 20016.199352025757, 20073.0, 20086.38876946017, 20207.393778186677, 1061.918639466654, 1068.625980906692, 1074.8065348237392, 1098.3025778630627, 1115.130198445214, 11031.172662050378, 11388.0, 11453.942730286462, 11489.540418383338, 11677.76644467123, 477875.83186252235, 492038.0, 507380.0, 507706.0, 519212.0, 56223.15665265024, 66740.0, 86418.56790716131, 95447.0, 99313.50343248382, 1059.6066172982503, 1077.8329358949375, 1083.7561548651647, 1113.771676806269, 1170.6546568762235, 17443.56391090233, 17507.03711295891, 17761.555961101076, 18187.363442279457, 18527.0, 37919.62080379161, 38921.0, 39012.609873900896, 39299.0, 41301.38047929344, 58440.123398148215, 59967.40032599793, 60562.69718651378, 60892.39107609045, 60911.69544152251, 8961.865572016555, 9208.815823683623, 9209.493477858781, 9227.76930576741, 9423.199028082416, 8510.531920744419, 10860.565577377132, 12221.450034748279, 13497.730045399234, 14246.786298205743, 12058.457369418222, 12131.332776697367, 12142.635720928387, 12266.693332666755, 12449.626511204679, 11046.613368532062, 11778.882211177779, 11955.820662690241, 12069.336186509827, 12235.510579577074, 6493.740250389931, 10441.530131143965, 10539.841902371318, 12394.380280986095, 12526.0, 8935.776605584912, 9078.45529268246, 9377.0, 9576.664816731382, 9672.322937394314, 9670.371425857578, 12077.335746533674, 12087.274763514217, 12318.630441086423, 12374.0], "value": 9520.840536655718, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.572839604911, 1554.316100915597, 1679.4122057279953, 1817.7273408988658, 1829.8353148216665, 7739.4969326993705, 8263.793405164874, 8502.234798868101, 8605.741827745162, 8726.825463490733, 8583.184597463247, 8604.569771511431, 8623.568821558913, 8640.39517233794, 8679.175478329564, 2319.8144148468123, 2352.5059737455153, 2353.7410884802657, 2355.9057637694473, 2356.0929042318744, 2352.1532248390567, 2355.3993731598503, 2397.8681172535503, 2398.0647547456506, 2401.579723548372, 2387.9641805372935, 2391.186996421225, 2393.461471168982, 2432.1730611592056, 2451.4239153798844, 2398.4963157736897, 2402.0631953538136, 2402.4714562796244, 2406.3502854229346, 2447.486027934136, 2384.487335222918, 2423.8788060597076, 2436.098643501916, 2439.329184474284, 2450.534398464304, 8781.34139939507, 8823.514706691129, 8823.779405514913, 8837.337199710048, 8842.425242359226, 5458.808941687062, 5648.971755141239, 5657.462541058593, 5659.717014149317, 5665.886682266373, 3585.8565657373933, 3585.9641403585892, 3603.279344131184, 3689.7048236141045, 3698.1863989922176, 1118.6532175025686, 1152.4353066997112, 1163.7032556698073, 1178.85853697556, 1207.8912897839236, 12260.938695306466, 12269.631911042683, 12393.690157746038, 12412.379381031004, 12453.1905426147, 4816.735079570587, 4899.4365647950945, 4934.5805606523845, 4968.701877887338, 5108.463611320833, 10597.41714205726, 10618.991195836383, 10627.14982801374, 10665.413402262795, 10676.786464270672, 5648.6893220872425, 5698.145278208219, 5701.059325211377, 5707.115397113371, 5724.0, 4967.081089998362, 5065.670731402447, 5074.644774865724, 5133.922991155136, 5209.817656382009, 4251.532331443539, 4267.210566045292, 4337.15425492026, 4440.644748420119, 4474.239379305526, 1345.488714288564, 1350.8108864758942, 1360.7210521842999, 1365.5220672764453, 1383.0387880423211, 903.0698380667923, 968.5738275158908, 1025.2259544044198, 1033.5917312661456, 1051.4217180550665, 5961.463468287875, 5991.310999235144, 6000.7899723510345, 6006.63960162383, 6016.69916504173, 489.8334566247493, 490.1789502583159, 491.36123040047795, 496.9031038947443, 496.91304021796043, 4041.555428902818, 4160.043190066302, 4187.874363769091, 4189.476315460567, 4222.978885105616, 10701.197410194267, 10900.236983411085, 10950.39772812503, 11045.723856903482, 11082.113430925507, 10065.949670251748, 10317.48412579368, 10810.62162824313, 10861.565537378416, 10877.456127193609, 8133.837323253501, 8162.102168761431, 8164.265216130458, 8170.509769413854, 8224.588770561328, 5955.0, 6139.259792094406, 6182.69086545662, 6234.9688251558455, 6285.0, 9615.807683846424, 9684.08001239881, 9721.027897210222, 9742.9025709742, 9777.853332200166, 9574.329796914428, 9912.0, 9950.55222515003, 9957.203423726229, 10029.197664186993, 7511.32398084175, 7718.382529397747, 7721.150673426031, 7825.569593672402, 7972.481788683717, 8129.349652027942, 8163.918360816316, 8178.46839955401, 8205.425620206528, 8251.051129120227, 7199.820004499929, 7344.816379590553, 7402.629868506661, 7535.585542795199, 7644.312011918954, 7048.224695283412, 7093.787186384417, 7100.254473280231, 7176.641167941686, 7234.095738032746, 6867.416269617139, 7060.964695176696, 7068.505204635626, 7069.081019467436, 7083.150021997393, 5021.372328458942, 5181.792728290977, 5234.398044224963, 5268.727982788677, 5324.6006549508165, 5405.648632838853, 5440.80302333486, 5447.591430642638, 5458.781648734006, 5536.972315138399], "value": 4645.899392579792, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.9684128428441, 354.64004035903565, 355.15650330465144, 355.7065421027652, 359.04852141824165, 6692.531522793406, 6705.698243579039, 6830.590164590116, 6850.76022339217, 6871.3815756581835, 6652.634105124216, 6712.261651218374, 6727.461803055756, 6735.966320168404, 6755.054292399068, 4872.439669438025, 5042.042012017714, 5044.596432285427, 5047.116754567955, 5051.6716413433005, 4977.07924034053, 4981.651284410093, 4981.850544483653, 4982.330919142092, 4991.575716064139, 4905.411350637928, 4926.605871530269, 4985.127602669537, 5011.198208286675, 5026.924596131061, 4974.10466116099, 4983.426905905831, 4984.501549845023, 4988.251762235675, 4989.950100498985, 4271.402003719481, 4296.548862369469, 4308.375285583573, 4314.417553630251, 4325.091730736549, 6432.421082102586, 6434.388733070351, 6438.7102580384, 6445.709943052574, 6449.3873082057125, 5665.518430933375, 5795.884082318372, 5840.182374467578, 5849.85375365615, 5866.794662186846, 6965.05971693825, 6998.790036298919, 7043.753468628624, 7064.540804847668, 7071.222165561784, 4768.094062128184, 4768.976155119237, 4774.976125119387, 4781.545753153445, 4790.449098353699, 7362.079740032496, 7435.814104647373, 7442.47902646815, 7443.0, 7443.106827180719, 4728.976355118271, 4907.386576677915, 4909.7790599423115, 4912.828051018198, 4921.901561968741, 4831.444383895827, 4853.369062021915, 4884.072026314989, 4884.194107972145, 4889.217725163957, 5680.11958146488, 5688.744006519716, 5705.486506214377, 5742.0, 5776.364599894008, 7094.148702155671, 7096.574205547684, 7096.645167741593, 7103.112110986127, 7105.538140020882, 1718.4758648612044, 1745.4327343613377, 1750.7023805953017, 1750.824917508239, 1754.1580041580114, 1106.1703722208345, 1129.4973736687095, 1134.0870599167583, 1138.59579849154, 1142.5544037825255, 6858.177018757781, 6878.312168783182, 6885.862282754417, 6894.517383783087, 6908.240093589701, 7310.342069213796, 7328.963355183297, 7354.595497247596, 7356.719416980646, 7362.8527429451115, 6785.728570857111, 6868.896966545506, 6893.448524118058, 6983.685734141975, 6990.6155161465595, 3986.7807270600397, 4012.1574469361176, 4016.5380981186954, 4019.41718450823, 4020.175863947942, 7712.575808330484, 7737.187595302525, 7738.148803631596, 7749.573773442515, 7759.456838021397, 7487.962560187164, 7515.774526764097, 7535.585542795199, 7554.244575542401, 7562.659680314399, 7440.702371905171, 7656.425768067417, 7667.118281397599, 7728.26581474759, 7735.458517903693, 7272.636368181676, 7294.598797066213, 7325.743598974011, 7379.631018449163, 7446.367058800062, 7310.378617817332, 7316.378107860892, 7319.963400183178, 7328.5969271690565, 7346.081739782528, 7610.543367397974, 7727.0727512696585, 7749.186335434698, 7761.805954850948, 7778.49439786412, 4987.7530617345665, 5101.234814777813, 5125.487451254845, 5127.615428842926, 5129.615278854176, 7300.23347548521, 7353.558786472829, 7356.595387253752, 7356.668949897375, 7367.594782286811, 7076.398506127037, 7099.467539934629, 7099.929000709927, 7103.573785572882, 7113.75101871432, 6903.75836845708, 7086.610236437045, 7091.574505529685, 7095.042169307284, 7098.964505177441, 6988.05661235747, 6995.125609298838, 6998.160220773336, 6999.860002800017, 7018.613976231356, 7140.178879428932, 7154.928450715426, 7174.820629484305, 7177.318154775288, 7179.0, 6958.304169583002, 6997.370236678723, 7000.089988301488, 7010.193827709879, 7012.4390048796995], "value": 5314.160581894668, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [916.1754421021076, 925.4493576322086, 925.8564922437023, 926.7127190570924, 941.2046820436728, 14412.783808242872, 14520.709585808278, 14525.0, 15783.447579334726, 15904.0, 15624.21878906053, 15655.765163522556, 15717.92141039296, 15777.447789327376, 15805.920970395133, 916.9266458683322, 921.0, 924.8843894513186, 927.3693888156051, 929.707142250189, 894.4186278918689, 932.1889955738517, 939.2204470289678, 939.7086903060039, 939.8355287824637, 973.3624475968252, 975.6731494949165, 976.6776963601994, 978.9657361992332, 980.7793246519548, 967.7338731848763, 971.5725080964388, 972.9318947673665, 974.055166488505, 975.3172779054655, 696.4080531548194, 698.9370956613878, 708.9468289878229, 714.2678754276908, 714.5319815520842, 14487.348069336906, 14522.564323070324, 14541.054831435922, 14559.927200364036, 14624.122552646875, 13737.175769453765, 13875.930620346935, 14502.347394367172, 14599.854001459955, 14625.707485850224, 11333.773324533464, 11609.883901161049, 11768.529258829636, 11955.342456164908, 11994.16040877139, 4505.684602077856, 4560.863174104782, 4618.56123668251, 4679.251319788817, 4728.196206644879, 56509.43490565083, 57286.0, 57373.713131434495, 57655.71172144154, 58288.70855645695, 11301.943490282496, 11314.0, 11319.264247823865, 11555.711107222218, 11703.122265829927, 20569.280075197297, 20642.690359644617, 20653.690194647093, 20668.48328791762, 20678.069486873126, 8203.83592328162, 8270.751877443687, 8329.750107496784, 8355.456895301908, 8631.956840215758, 4952.975235123801, 4965.155923493015, 5035.169197082514, 5094.465081166424, 5210.296609957683, 3514.8066856322635, 3547.8048707321345, 3570.250247448013, 3570.571531416195, 3572.1248294168095, 646.7833275852643, 647.2847503508649, 647.7700416352127, 669.8024082895557, 671.7514519627769, 678.6878036103448, 788.6175205025557, 790.4269404681675, 813.5606772342987, 824.6866190847439, 9540.284478664127, 9859.50702464874, 10077.294589378673, 10091.7477063074, 10118.291719579558, 652.1749986267375, 798.7483942558192, 807.8707406814881, 814.8329592433537, 817.7260617693021, 4427.889302767392, 4477.664175186809, 4481.058977614737, 4514.503404625489, 4515.435570553681, 66134.33865661378, 66929.66535167293, 67081.66459167673, 67242.0, 67688.0, 57570.42429575651, 58013.709931450074, 59156.40843591595, 59185.0, 59321.0, 51524.742376287875, 51592.74203629033, 51624.0, 52938.47061529335, 53198.20202696963, 8621.741347759576, 8721.127887211229, 8817.382783205114, 8906.109389061043, 9021.32340074484, 38606.0, 38889.22221555497, 39728.80135599419, 39995.600043999184, 40336.59663403328, 45902.0, 46232.76883615561, 51276.23085653644, 51547.48452515427, 52023.47976520186, 10656.413897235416, 10755.516001779783, 10885.945570272099, 11049.72375690582, 11148.665540033811, 12859.485620575073, 13117.868821312046, 13155.934220328838, 13191.0, 13214.735705286033, 12266.386680665753, 12269.263844169378, 12348.073894457772, 12491.625251242478, 12590.685232868886, 11107.888921110685, 11165.0, 11259.437028148395, 11283.887161128612, 11384.658460246206, 12398.380080996094, 12553.811692824798, 12800.16798908068, 13379.933100334436, 13497.122687025312, 10988.230823842574, 11008.834867477155, 11011.174161937726, 11032.834507482234, 11223.158263130135, 10598.735031624272, 11224.55101795919, 11342.489587968395, 11537.134714896249, 11597.6520704379], "value": 7155.160552879602, "unit": "score"}], "name": "dromaeo_css", "value": 7568.689612672544, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 103.0, 111.0, 118.0, 113.0, 100.0, 112.0, 111.0, 110.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 126.0, 150.0, 185.0, 128.0, 159.0, 158.0, 133.0, 179.0, 126.0], "value": 150.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 162.0, 163.0, 164.0, 164.0, 163.0, 163.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 78.0, 181.0, 76.0, 76.0, 76.0, 74.0, 173.0, 74.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 146.0, 92.0, 92.0, 92.0, 145.0, 91.0, 91.0, 146.0], "value": 107.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0, 118.0, 116.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 150.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 58.0, 54.0, 55.0, 56.0, 60.0, 79.0, 66.0, 54.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 58.0, 57.0, 58.0, 57.0, 60.0, 58.0, 58.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 74.0, 74.0, 75.0, 75.0, 74.0, 74.0, 74.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 127.0, 124.0, 117.0, 118.0, 123.0, 112.0, 117.0, 133.0, 145.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 158.0, 159.0, 166.0, 159.0, 156.0, 157.0, 163.0, 164.0, 156.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 65.0, 76.0, 69.0, 66.0, 66.0, 67.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1528.3, "alertThreshold": 2.0}]} 11:25:12 INFO - Return code: 0 11:25:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:25:12 ERROR - # TBPL SUCCESS # 11:25:12 INFO - Running post-action listener: _resource_record_post_action 11:25:12 INFO - Running post-run listener: _resource_record_post_run 11:25:13 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462032896; Read time: 16; Write time: 490368 11:25:13 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242044928; Read time: 0; Write time: 309556 11:25:13 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 219451392; Read time: 16; Write time: 180812 11:25:13 INFO - Running post-run listener: _upload_blobber_files 11:25:13 INFO - Blob upload gear active. 11:25:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:25:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:25:13 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:25:13 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:25:13 INFO - (blobuploader) - INFO - Open directory for files ... 11:25:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:25:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:25:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:14 INFO - (blobuploader) - INFO - Done attempting. 11:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:25:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:25:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:25:15 INFO - (blobuploader) - INFO - Done attempting. 11:25:15 INFO - (blobuploader) - INFO - Iteration through files over. 11:25:15 INFO - Return code: 0 11:25:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:25:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:25:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01bb0dff56129a6e7b746b5af552979dbc14c77879432b9ae782a8ecf5eaed95db95fffa6f33b0ccbf294e20152438b1ad44e0ac3ac2eab392bf7fb3b707c4de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e859929091e1c2c65cc606161aa6ed2e8403fe178db94dbd33b78292ebd43093d3cde4e7f51b21189086f1026545262f66a364e11935b32cc5544f0f0b36f99"} 11:25:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:25:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:25:15 INFO - Contents: 11:25:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01bb0dff56129a6e7b746b5af552979dbc14c77879432b9ae782a8ecf5eaed95db95fffa6f33b0ccbf294e20152438b1ad44e0ac3ac2eab392bf7fb3b707c4de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e859929091e1c2c65cc606161aa6ed2e8403fe178db94dbd33b78292ebd43093d3cde4e7f51b21189086f1026545262f66a364e11935b32cc5544f0f0b36f99"} 11:25:15 INFO - Running post-run listener: copy_logs_to_upload_dir 11:25:15 INFO - Copying logs to upload dir... 11:25:15 INFO - mkdir: /builds/slave/test/build/upload/logs 11:25:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.967045 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-15 11:25:14.809612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 11:25:14.812873) ========= 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=fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662 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/Mozilla-Beta/sha512/01bb0dff56129a6e7b746b5af552979dbc14c77879432b9ae782a8ecf5eaed95db95fffa6f33b0ccbf294e20152438b1ad44e0ac3ac2eab392bf7fb3b707c4de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e859929091e1c2c65cc606161aa6ed2e8403fe178db94dbd33b78292ebd43093d3cde4e7f51b21189086f1026545262f66a364e11935b32cc5544f0f0b36f99"} build_url:https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011493 build_url: 'https://queue.taskcluster.net/v1/task/YekjWESBS_yal24RD_0qmQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/01bb0dff56129a6e7b746b5af552979dbc14c77879432b9ae782a8ecf5eaed95db95fffa6f33b0ccbf294e20152438b1ad44e0ac3ac2eab392bf7fb3b707c4de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8e859929091e1c2c65cc606161aa6ed2e8403fe178db94dbd33b78292ebd43093d3cde4e7f51b21189086f1026545262f66a364e11935b32cc5544f0f0b36f99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 11:25:14.838706) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:25:14.839031) ========= 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=fa44defc139c4ba8574fe040000001db-1466013629.84118-19205662 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 11:25:14.922999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 11:25:14.923308) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 11:25:14.923584) ========= ========= Total master_lag: 0.16 =========