builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1467240660.96 results: success (0) buildid: 20160629130426 builduid: a895d54ff7bf40d0a65922a67a781542 revision: ee43fafecf41bc2048b100e1fe2e272144884d19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:00.959482) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:00.960425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:00.960914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:00.998519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:00.998892) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 15:51:02-- 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% 69.7M=0s 2016-06-29 15:51:02 (69.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108107 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.124074) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.124571) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019654 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.181329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.181882) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ee43fafecf41bc2048b100e1fe2e272144884d19 --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 ee43fafecf41bc2048b100e1fe2e272144884d19 --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=82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 15:51:02,621 truncating revision to first 12 chars 2016-06-29 15:51:02,621 Setting DEBUG logging. 2016-06-29 15:51:02,621 attempt 1/10 2016-06-29 15:51:02,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ee43fafecf41?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 15:51:02,924 unpacking tar archive at: mozilla-beta-ee43fafecf41/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.845304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.845646) ========= script_repo_revision: ee43fafecf41bc2048b100e1fe2e272144884d19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.846066) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.846333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:51:01.856651) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-06-29 15:51:01.857038) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:51:03 INFO - MultiFileLogger online at 20160629 15:51:03 in /builds/slave/test 15:51:03 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 15:51:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:51:03 INFO - {'append_to_log': False, 15:51:03 INFO - 'base_work_dir': '/builds/slave/test', 15:51:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:51:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:51:03 INFO - 'branch': 'Mozilla-Beta', 15:51:03 INFO - 'buildbot_json_path': 'buildprops.json', 15:51:03 INFO - 'config_files': ('talos/linux_config.py',), 15:51:03 INFO - 'default_actions': ('clobber', 15:51:03 INFO - 'read-buildbot-config', 15:51:03 INFO - 'download-and-extract', 15:51:03 INFO - 'populate-webroot', 15:51:03 INFO - 'create-virtualenv', 15:51:03 INFO - 'install', 15:51:03 INFO - 'run-tests'), 15:51:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:51:03 INFO - 'download_minidump_stackwalk': True, 15:51:03 INFO - 'download_symbols': 'ondemand', 15:51:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:51:03 INFO - 'tooltool.py': '/tools/tooltool.py', 15:51:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:51:03 INFO - '/tools/misc-python/virtualenv.py')}, 15:51:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:51:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:51:03 INFO - 'installer_path': 'installer.exe', 15:51:03 INFO - 'log_level': 'info', 15:51:03 INFO - 'log_name': 'talos', 15:51:03 INFO - 'log_to_console': True, 15:51:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:51:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:51:03 INFO - 'opt_config_files': (), 15:51:03 INFO - 'pip_index': False, 15:51:03 INFO - 'sps_profile': False, 15:51:03 INFO - 'sps_profile_interval': 0, 15:51:03 INFO - 'suite': 'dromaeojs-e10s', 15:51:03 INFO - 'system_bits': '32', 15:51:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:51:03 INFO - 'title': 'talos-linux64-ix-066', 15:51:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:51:03 INFO - 'use_talos_json': True, 15:51:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:51:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:51:03 INFO - 'work_dir': 'build'} 15:51:03 INFO - ##### 15:51:03 INFO - ##### Running clobber step. 15:51:03 INFO - ##### 15:51:03 INFO - Running pre-action listener: _resource_record_pre_action 15:51:03 INFO - Running main action method: clobber 15:51:03 INFO - rmtree: /builds/slave/test/build 15:51:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:51:04 INFO - Running post-action listener: _resource_record_post_action 15:51:04 INFO - ##### 15:51:04 INFO - ##### Running read-buildbot-config step. 15:51:04 INFO - ##### 15:51:04 INFO - Running pre-action listener: _resource_record_pre_action 15:51:04 INFO - Running main action method: read_buildbot_config 15:51:04 INFO - Using buildbot properties: 15:51:04 INFO - { 15:51:04 INFO - "project": "", 15:51:04 INFO - "product": "firefox", 15:51:04 INFO - "script_repo_revision": "production", 15:51:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 15:51:04 INFO - "repository": "", 15:51:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 15:51:04 INFO - "buildid": "20160629130426", 15:51:04 INFO - "pgo_build": "True", 15:51:04 INFO - "basedir": "/builds/slave/test", 15:51:04 INFO - "buildnumber": 72, 15:51:04 INFO - "slavename": "talos-linux64-ix-066", 15:51:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:51:04 INFO - "platform": "ubuntu64_hw", 15:51:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:51:04 INFO - "branch": "mozilla-beta", 15:51:04 INFO - "repo_path": "releases/mozilla-beta", 15:51:04 INFO - "revision": "ee43fafecf41bc2048b100e1fe2e272144884d19", 15:51:04 INFO - "stage_platform": "linux64-pgo", 15:51:04 INFO - "builduid": "a895d54ff7bf40d0a65922a67a781542", 15:51:04 INFO - "slavebuilddir": "test" 15:51:04 INFO - } 15:51:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 15:51:04 INFO - Running post-action listener: _resource_record_post_action 15:51:04 INFO - ##### 15:51:04 INFO - ##### Running download-and-extract step. 15:51:04 INFO - ##### 15:51:04 INFO - Running pre-action listener: _resource_record_pre_action 15:51:04 INFO - Running main action method: download_and_extract 15:51:04 INFO - mkdir: /builds/slave/test/build/tests 15:51:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:04 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:51:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:51:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:51:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:51:06 INFO - Downloaded 1327 bytes. 15:51:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 15:51:06 INFO - Using the following test package requirements: 15:51:06 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:51:06 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:06 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:51:06 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:06 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 15:51:06 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:06 INFO - u'jsshell-linux-x86_64.zip'], 15:51:06 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:06 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:51:06 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 15:51:06 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:06 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 15:51:06 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:06 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 15:51:06 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:06 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:51:06 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 15:51:06 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:51:06 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:06 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:51:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:51:18 INFO - Downloaded 24235306 bytes. 15:51:18 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'] 15:51:18 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 15:51:19 INFO - Return code: 0 15:51:19 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 15:51:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:19 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:51:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 15:51:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:51:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:52:42 INFO - Downloaded 24235306 bytes. 15:52:42 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'] 15:52:42 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 15:52:43 INFO - Return code: 0 15:52: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')]} 15:52:43 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:52:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:52:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 15:52:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:52:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:52:44 INFO - Downloaded 10840145 bytes. 15:52:44 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'] 15:52:44 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 15:52:44 INFO - Return code: 0 15:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:44 INFO - https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:52:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:52:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:52:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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 15:52:46 INFO - Downloaded 56000752 bytes. 15:52:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:52:46 INFO - mkdir: /builds/slave/test/properties 15:52:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:52:46 INFO - Writing to file /builds/slave/test/properties/build_url 15:52:46 INFO - Contents: 15:52:46 INFO - build_url:https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 15:52:46 INFO - Running post-action listener: _resource_record_post_action 15:52:46 INFO - Running post-action listener: set_extra_try_arguments 15:52:46 INFO - ##### 15:52:46 INFO - ##### Running populate-webroot step. 15:52:46 INFO - ##### 15:52:46 INFO - Running pre-action listener: _resource_record_pre_action 15:52:46 INFO - Running main action method: populate_webroot 15:52:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:52:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:52:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:52:46 INFO - '--tppagecycles', 15:52:46 INFO - '7'], 15:52:46 INFO - 'tests': ['tsvgm']}}, 15:52:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:52:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:52:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:52:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:52:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:46 INFO - 'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:52:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:46 INFO - 'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['damp', 'tps']}, 15:52:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:46 INFO - 'tests': ['damp', 'tps']}, 15:52:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['dromaeo_dom']}, 15:52:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:52:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['a11yr', 15:52:46 INFO - 'ts_paint', 15:52:46 INFO - 'tpaint', 15:52:46 INFO - 'sessionrestore', 15:52:46 INFO - 'sessionrestore_no_auto_restore', 15:52:46 INFO - 'tabpaint']}, 15:52:46 INFO - 'other-e10s': {'tests': ['a11yr', 15:52:46 INFO - 'ts_paint', 15:52:46 INFO - 'tpaint', 15:52:46 INFO - 'sessionrestore', 15:52:46 INFO - 'sessionrestore_no_auto_restore', 15:52:46 INFO - 'tabpaint']}, 15:52:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:52:46 INFO - 'ts_paint', 15:52:46 INFO - 'tpaint', 15:52:46 INFO - 'sessionrestore', 15:52:46 INFO - 'sessionrestore_no_auto_restore', 15:52:46 INFO - 'tabpaint']}, 15:52:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:52:46 INFO - 'ts_paint', 15:52:46 INFO - 'tpaint', 15:52:46 INFO - 'sessionrestore', 15:52:46 INFO - 'sessionrestore_no_auto_restore', 15:52:46 INFO - 'tabpaint']}, 15:52:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['a11yr', 15:52:46 INFO - 'ts_paint', 15:52:46 INFO - 'tpaint', 15:52:46 INFO - 'sessionrestore', 15:52:46 INFO - 'sessionrestore_no_auto_restore', 15:52:46 INFO - 'tabpaint']}, 15:52:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['a11yr', 15:52:46 INFO - 'ts_paint', 15:52:46 INFO - 'tpaint', 15:52:46 INFO - 'sessionrestore', 15:52:46 INFO - 'sessionrestore_no_auto_restore', 15:52:46 INFO - 'tabpaint']}, 15:52:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['tsvgx', 15:52:46 INFO - 'tsvgr_opacity', 15:52:46 INFO - 'tart', 15:52:46 INFO - 'tscrollx', 15:52:46 INFO - 'cart']}, 15:52:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:52:46 INFO - 'tsvgr_opacity', 15:52:46 INFO - 'tart', 15:52:46 INFO - 'tscrollx', 15:52:46 INFO - 'cart']}, 15:52:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:46 INFO - 'talos_options': ['--disable-e10s'], 15:52:46 INFO - 'tests': ['tp5o']}, 15:52:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:46 INFO - 'tests': ['tp5o']}, 15:52:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:46 INFO - 'talos_options': ['--disable-e10s', 15:52:46 INFO - '--xperf_path', 15:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:46 INFO - 'tests': ['tp5n']}, 15:52:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:52:46 INFO - 'talos_options': ['--xperf_path', 15:52:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:52:46 INFO - 'tests': ['tp5n']}}, 15:52:46 INFO - 'talos.zip': {'path': '', 15:52:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:52:46 INFO - Running post-action listener: _resource_record_post_action 15:52:46 INFO - ##### 15:52:46 INFO - ##### Running create-virtualenv step. 15:52:46 INFO - ##### 15:52:46 INFO - Running pre-action listener: _resource_record_pre_action 15:52:46 INFO - Running main action method: create_virtualenv 15:52:46 INFO - Creating virtualenv /builds/slave/test/build/venv 15:52:46 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 15:52:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:52:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:52:47 INFO - Using real prefix '/usr' 15:52:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:52:47 INFO - Installing distribute.............................................................................................................................................................................................done. 15:52:49 INFO - Installing pip.................done. 15:52:49 INFO - Return code: 0 15:52:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:52:49 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')]} 15:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:49 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')]} 15:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:49 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 0x7f1d8a9fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', '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 15:52:49 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 15:52:49 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 15:52:49 INFO - Using env: {'DISPLAY': ':0', 15:52:49 INFO - 'HOME': '/home/cltbld', 15:52:49 INFO - 'LANG': 'en_US.UTF-8', 15:52:49 INFO - 'LANGUAGE': 'en_US:en', 15:52:49 INFO - 'LOGNAME': 'cltbld', 15:52:49 INFO - 'MAIL': '/var/mail/cltbld', 15:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:49 INFO - 'MOZ_NO_REMOTE': '1', 15:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:49 INFO - 'NO_EM_RESTART': '1', 15:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:49 INFO - 'PWD': '/builds/slave/test', 15:52:49 INFO - 'SHELL': '/bin/bash', 15:52:49 INFO - 'SHLVL': '1', 15:52:49 INFO - 'TERM': 'linux', 15:52:49 INFO - 'TMOUT': '86400', 15:52:49 INFO - 'USER': 'cltbld', 15:52:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:49 INFO - '_': '/tools/buildbot/bin/python'} 15:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:49 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 15:52:49 INFO - Cleaning up... 15:52:49 INFO - Return code: 0 15:52:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:52:49 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')]} 15:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:49 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')]} 15:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:49 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 0x7f1d8a9fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', '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 15:52:49 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 15:52:49 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 15:52:49 INFO - Using env: {'DISPLAY': ':0', 15:52:49 INFO - 'HOME': '/home/cltbld', 15:52:49 INFO - 'LANG': 'en_US.UTF-8', 15:52:49 INFO - 'LANGUAGE': 'en_US:en', 15:52:49 INFO - 'LOGNAME': 'cltbld', 15:52:49 INFO - 'MAIL': '/var/mail/cltbld', 15:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:49 INFO - 'MOZ_NO_REMOTE': '1', 15:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:49 INFO - 'NO_EM_RESTART': '1', 15:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:49 INFO - 'PWD': '/builds/slave/test', 15:52:49 INFO - 'SHELL': '/bin/bash', 15:52:49 INFO - 'SHLVL': '1', 15:52:49 INFO - 'TERM': 'linux', 15:52:49 INFO - 'TMOUT': '86400', 15:52:49 INFO - 'USER': 'cltbld', 15:52:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:49 INFO - '_': '/tools/buildbot/bin/python'} 15:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:49 INFO - Downloading/unpacking psutil>=0.7.1 15:52:49 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 15:52:49 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 15:52:49 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 15:52:49 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 15:52:49 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 15:52:49 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 15:52:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:52:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:51 INFO - Installing collected packages: psutil 15:52:51 INFO - Running setup.py install for psutil 15:52:52 INFO - building 'psutil._psutil_linux' extension 15:52:52 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 15:52:52 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 15:52:52 INFO - building 'psutil._psutil_posix' extension 15:52:52 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 15:52:52 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 15:52:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:52:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:52:52 INFO - Successfully installed psutil 15:52:52 INFO - Cleaning up... 15:52:52 INFO - Return code: 0 15:52:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:52 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 0x7f1d8a9fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', '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 15:52:52 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 15:52:52 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 15:52:52 INFO - Using env: {'DISPLAY': ':0', 15:52:52 INFO - 'HOME': '/home/cltbld', 15:52:52 INFO - 'LANG': 'en_US.UTF-8', 15:52:52 INFO - 'LANGUAGE': 'en_US:en', 15:52:52 INFO - 'LOGNAME': 'cltbld', 15:52:52 INFO - 'MAIL': '/var/mail/cltbld', 15:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:52 INFO - 'MOZ_NO_REMOTE': '1', 15:52:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:52 INFO - 'NO_EM_RESTART': '1', 15:52:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:52 INFO - 'PWD': '/builds/slave/test', 15:52:52 INFO - 'SHELL': '/bin/bash', 15:52:52 INFO - 'SHLVL': '1', 15:52:52 INFO - 'TERM': 'linux', 15:52:52 INFO - 'TMOUT': '86400', 15:52:52 INFO - 'USER': 'cltbld', 15:52:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:52 INFO - '_': '/tools/buildbot/bin/python'} 15:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:52:52 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 15:52:52 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 15:52:52 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 15:52:52 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 15:52:52 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 15:52:52 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 15:52:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:52:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:52:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:52:54 INFO - Installing collected packages: mozsystemmonitor 15:52:54 INFO - Running setup.py install for mozsystemmonitor 15:52:54 INFO - Successfully installed mozsystemmonitor 15:52:54 INFO - Cleaning up... 15:52:54 INFO - Return code: 0 15:52:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:54 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 0x7f1d8a9fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', '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 15:52:54 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 15:52:54 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 15:52:54 INFO - Using env: {'DISPLAY': ':0', 15:52:54 INFO - 'HOME': '/home/cltbld', 15:52:54 INFO - 'LANG': 'en_US.UTF-8', 15:52:54 INFO - 'LANGUAGE': 'en_US:en', 15:52:54 INFO - 'LOGNAME': 'cltbld', 15:52:54 INFO - 'MAIL': '/var/mail/cltbld', 15:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:54 INFO - 'MOZ_NO_REMOTE': '1', 15:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:54 INFO - 'NO_EM_RESTART': '1', 15:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:54 INFO - 'PWD': '/builds/slave/test', 15:52:54 INFO - 'SHELL': '/bin/bash', 15:52:54 INFO - 'SHLVL': '1', 15:52:54 INFO - 'TERM': 'linux', 15:52:54 INFO - 'TMOUT': '86400', 15:52:54 INFO - 'USER': 'cltbld', 15:52:54 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:54 INFO - '_': '/tools/buildbot/bin/python'} 15:52:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:52:55 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 15:52:55 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 15:52:55 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 15:52:55 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 15:52:55 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 15:52:55 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 15:52:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:52:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:52:57 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 15:52:57 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 15:52:57 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 15:52:57 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 15:52:57 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 15:52:57 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 15:52:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:52:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:52:57 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 15:52:57 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 15:52:57 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 15:52:57 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 15:52:57 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 15:52:57 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 15:52:57 INFO - Downloading docopt-0.6.1.tar.gz 15:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:52:58 INFO - Installing collected packages: blobuploader, requests, docopt 15:52:58 INFO - Running setup.py install for blobuploader 15:52:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:52:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:52:58 INFO - Running setup.py install for requests 15:52:58 INFO - Running setup.py install for docopt 15:52:58 INFO - Successfully installed blobuploader requests docopt 15:52:58 INFO - Cleaning up... 15:52:58 INFO - Return code: 0 15:52:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:52:58 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')]} 15:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:52:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:58 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')]} 15:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:52:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:52:58 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 0x7f1d8a9fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', '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 15:52:58 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 15:52:58 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 15:52:58 INFO - Using env: {'DISPLAY': ':0', 15:52:58 INFO - 'HOME': '/home/cltbld', 15:52:58 INFO - 'LANG': 'en_US.UTF-8', 15:52:58 INFO - 'LANGUAGE': 'en_US:en', 15:52:58 INFO - 'LOGNAME': 'cltbld', 15:52:58 INFO - 'MAIL': '/var/mail/cltbld', 15:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:58 INFO - 'MOZ_NO_REMOTE': '1', 15:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:58 INFO - 'NO_EM_RESTART': '1', 15:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:52:58 INFO - 'PWD': '/builds/slave/test', 15:52:58 INFO - 'SHELL': '/bin/bash', 15:52:58 INFO - 'SHLVL': '1', 15:52:58 INFO - 'TERM': 'linux', 15:52:58 INFO - 'TMOUT': '86400', 15:52:58 INFO - 'USER': 'cltbld', 15:52:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:58 INFO - '_': '/tools/buildbot/bin/python'} 15:52:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:52:58 INFO - Running setup.py (path:/tmp/pip-1x_Avi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:52:59 INFO - Running setup.py (path:/tmp/pip-oUB1TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:52:59 INFO - Running setup.py (path:/tmp/pip-pXX7sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:52:59 INFO - Running setup.py (path:/tmp/pip-KIzxNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:52:59 INFO - Running setup.py (path:/tmp/pip-vdZIWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:52:59 INFO - Running setup.py (path:/tmp/pip-l4LGWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:52:59 INFO - Running setup.py (path:/tmp/pip-61dWVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:52:59 INFO - Running setup.py (path:/tmp/pip-K5Z7eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:52:59 INFO - Running setup.py (path:/tmp/pip-ENZo4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:52:59 INFO - Running setup.py (path:/tmp/pip-F0mw0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:52:59 INFO - Running setup.py (path:/tmp/pip-z1UepF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:52:59 INFO - Running setup.py (path:/tmp/pip-9y45WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:52:59 INFO - Running setup.py (path:/tmp/pip-l89067-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:52:59 INFO - Running setup.py (path:/tmp/pip-W9M9Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:52:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:52:59 INFO - Running setup.py (path:/tmp/pip-_Czzxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:00 INFO - Running setup.py (path:/tmp/pip-gQf6OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:00 INFO - Running setup.py (path:/tmp/pip-8tRKp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:00 INFO - Running setup.py install for manifestparser 15:53:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Running setup.py install for mozcrash 15:53:00 INFO - Running setup.py install for mozdebug 15:53:00 INFO - Running setup.py install for mozdevice 15:53:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Running setup.py install for mozfile 15:53:00 INFO - Running setup.py install for mozhttpd 15:53:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Running setup.py install for mozinfo 15:53:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Running setup.py install for mozInstall 15:53:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:00 INFO - Running setup.py install for mozleak 15:53:01 INFO - Running setup.py install for mozlog 15:53:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:01 INFO - Running setup.py install for moznetwork 15:53:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:01 INFO - Running setup.py install for mozprocess 15:53:01 INFO - Running setup.py install for mozprofile 15:53:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:01 INFO - Running setup.py install for mozrunner 15:53:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:01 INFO - Running setup.py install for mozscreenshot 15:53:01 INFO - Running setup.py install for moztest 15:53:01 INFO - Running setup.py install for mozversion 15:53:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:01 INFO - Cleaning up... 15:53:01 INFO - Return code: 0 15:53:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:01 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 0x7f1d8a9fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', '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 15:53:01 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 15:53:01 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 15:53:01 INFO - Using env: {'DISPLAY': ':0', 15:53:01 INFO - 'HOME': '/home/cltbld', 15:53:01 INFO - 'LANG': 'en_US.UTF-8', 15:53:01 INFO - 'LANGUAGE': 'en_US:en', 15:53:01 INFO - 'LOGNAME': 'cltbld', 15:53:01 INFO - 'MAIL': '/var/mail/cltbld', 15:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:01 INFO - 'MOZ_NO_REMOTE': '1', 15:53:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:01 INFO - 'NO_EM_RESTART': '1', 15:53:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:01 INFO - 'PWD': '/builds/slave/test', 15:53:01 INFO - 'SHELL': '/bin/bash', 15:53:01 INFO - 'SHLVL': '1', 15:53:01 INFO - 'TERM': 'linux', 15:53:01 INFO - 'TMOUT': '86400', 15:53:01 INFO - 'USER': 'cltbld', 15:53:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:01 INFO - '_': '/tools/buildbot/bin/python'} 15:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:02 INFO - Running setup.py (path:/tmp/pip-jGmRvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:02 INFO - Running setup.py (path:/tmp/pip-FB1Bak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:02 INFO - Running setup.py (path:/tmp/pip-nnIwPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:02 INFO - Running setup.py (path:/tmp/pip-yecUTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:02 INFO - Running setup.py (path:/tmp/pip-HME5xG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:02 INFO - Running setup.py (path:/tmp/pip-vS2U6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:02 INFO - Running setup.py (path:/tmp/pip-1gzCCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:02 INFO - Running setup.py (path:/tmp/pip-yswda6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:02 INFO - Running setup.py (path:/tmp/pip-kq2_Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:02 INFO - Running setup.py (path:/tmp/pip-BqnEe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:02 INFO - Running setup.py (path:/tmp/pip-1Q5GNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:02 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)) 15:53:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:02 INFO - Running setup.py (path:/tmp/pip-cqlqXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:03 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)) 15:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:03 INFO - Running setup.py (path:/tmp/pip-ohEwHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:03 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)) 15:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:03 INFO - Running setup.py (path:/tmp/pip-nVFlVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:03 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)) 15:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:03 INFO - Running setup.py (path:/tmp/pip-S7WbSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:03 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)) 15:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:03 INFO - Running setup.py (path:/tmp/pip-lcFSEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:03 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)) 15:53:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:03 INFO - Running setup.py (path:/tmp/pip-lsICDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:03 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)) 15:53:03 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)) 15:53:03 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)) 15:53:03 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)) 15:53:03 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)) 15:53:03 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)) 15:53:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:03 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 15:53:03 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 15:53:03 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 15:53:03 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 15:53:03 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 15:53:03 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 15:53:05 INFO - Downloading blessings-1.6.tar.gz 15:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:05 INFO - Installing collected packages: blessings 15:53:05 INFO - Running setup.py install for blessings 15:53:05 INFO - Successfully installed blessings 15:53:05 INFO - Cleaning up... 15:53:05 INFO - Return code: 0 15:53:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:05 INFO - Reading from file tmpfile_stdout 15:53:05 INFO - Current package versions: 15:53:05 INFO - argparse == 1.2.1 15:53:05 INFO - blessings == 1.6 15:53:05 INFO - blobuploader == 1.2.4 15:53:05 INFO - docopt == 0.6.1 15:53:05 INFO - manifestparser == 1.1 15:53:05 INFO - mozInstall == 1.12 15:53:05 INFO - mozcrash == 0.17 15:53:05 INFO - mozdebug == 0.1 15:53:05 INFO - mozdevice == 0.48 15:53:05 INFO - mozfile == 1.2 15:53:05 INFO - mozhttpd == 0.7 15:53:05 INFO - mozinfo == 0.9 15:53:05 INFO - mozleak == 0.1 15:53:05 INFO - mozlog == 3.1 15:53:05 INFO - moznetwork == 0.27 15:53:05 INFO - mozprocess == 0.22 15:53:05 INFO - mozprofile == 0.28 15:53:05 INFO - mozrunner == 6.11 15:53:05 INFO - mozscreenshot == 0.1 15:53:05 INFO - mozsystemmonitor == 0.0 15:53:05 INFO - moztest == 0.7 15:53:05 INFO - mozversion == 1.4 15:53:05 INFO - psutil == 3.1.1 15:53:05 INFO - requests == 1.2.3 15:53:05 INFO - wsgiref == 0.1.2 15:53:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:05 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 0x7f1d8a9fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', '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 15:53:05 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 15:53:05 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 15:53:05 INFO - Using env: {'DISPLAY': ':0', 15:53:05 INFO - 'HOME': '/home/cltbld', 15:53:05 INFO - 'LANG': 'en_US.UTF-8', 15:53:05 INFO - 'LANGUAGE': 'en_US:en', 15:53:05 INFO - 'LOGNAME': 'cltbld', 15:53:05 INFO - 'MAIL': '/var/mail/cltbld', 15:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:05 INFO - 'MOZ_NO_REMOTE': '1', 15:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:05 INFO - 'NO_EM_RESTART': '1', 15:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:05 INFO - 'PWD': '/builds/slave/test', 15:53:05 INFO - 'SHELL': '/bin/bash', 15:53:05 INFO - 'SHLVL': '1', 15:53:05 INFO - 'TERM': 'linux', 15:53:05 INFO - 'TMOUT': '86400', 15:53:05 INFO - 'USER': 'cltbld', 15:53:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:05 INFO - '_': '/tools/buildbot/bin/python'} 15:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:05 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)) 15:53:05 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)) 15:53:05 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)) 15:53:05 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)) 15:53:05 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)) 15:53:05 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)) 15:53:05 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)) 15:53:05 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)) 15:53:05 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)) 15:53:05 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)) 15:53:05 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)) 15:53:05 INFO - Cleaning up... 15:53:05 INFO - Return code: 0 15:53:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8a9fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', '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 15:53: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', 'jsonschema'] in /builds/slave/test/build 15:53: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 jsonschema 15:53:05 INFO - Using env: {'DISPLAY': ':0', 15:53:05 INFO - 'HOME': '/home/cltbld', 15:53:05 INFO - 'LANG': 'en_US.UTF-8', 15:53:05 INFO - 'LANGUAGE': 'en_US:en', 15:53:05 INFO - 'LOGNAME': 'cltbld', 15:53:05 INFO - 'MAIL': '/var/mail/cltbld', 15:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:05 INFO - 'MOZ_NO_REMOTE': '1', 15:53:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:05 INFO - 'NO_EM_RESTART': '1', 15:53:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:05 INFO - 'PWD': '/builds/slave/test', 15:53:05 INFO - 'SHELL': '/bin/bash', 15:53:05 INFO - 'SHLVL': '1', 15:53:05 INFO - 'TERM': 'linux', 15:53:05 INFO - 'TMOUT': '86400', 15:53:05 INFO - 'USER': 'cltbld', 15:53:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:05 INFO - '_': '/tools/buildbot/bin/python'} 15:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:06 INFO - Downloading/unpacking jsonschema 15:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:08 INFO - Downloading/unpacking functools32 (from jsonschema) 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:08 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:08 INFO - warning: no files found matching '*.txt' 15:53:08 INFO - no previously-included directories found matching 'build' 15:53:08 INFO - no previously-included directories found matching 'dist' 15:53:08 INFO - no previously-included directories found matching '.git*' 15:53:08 INFO - Installing collected packages: jsonschema, functools32 15:53:08 INFO - Running setup.py install for functools32 15:53:08 INFO - warning: no files found matching '*.txt' 15:53:08 INFO - no previously-included directories found matching 'build' 15:53:08 INFO - no previously-included directories found matching 'dist' 15:53:08 INFO - no previously-included directories found matching '.git*' 15:53:08 INFO - Successfully installed jsonschema functools32 15:53:08 INFO - Cleaning up... 15:53:08 INFO - Return code: 0 15:53:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d8a9fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bae8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c795a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', '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 15:53: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', 'flake8'] in /builds/slave/test/build 15:53: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 flake8 15:53:08 INFO - Using env: {'DISPLAY': ':0', 15:53:08 INFO - 'HOME': '/home/cltbld', 15:53:08 INFO - 'LANG': 'en_US.UTF-8', 15:53:08 INFO - 'LANGUAGE': 'en_US:en', 15:53:08 INFO - 'LOGNAME': 'cltbld', 15:53:08 INFO - 'MAIL': '/var/mail/cltbld', 15:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:08 INFO - 'MOZ_NO_REMOTE': '1', 15:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:08 INFO - 'NO_EM_RESTART': '1', 15:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:08 INFO - 'PWD': '/builds/slave/test', 15:53:08 INFO - 'SHELL': '/bin/bash', 15:53:08 INFO - 'SHLVL': '1', 15:53:08 INFO - 'TERM': 'linux', 15:53:08 INFO - 'TMOUT': '86400', 15:53:08 INFO - 'USER': 'cltbld', 15:53:08 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:08 INFO - '_': '/tools/buildbot/bin/python'} 15:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:08 INFO - Downloading/unpacking flake8 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:53:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:53:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53: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 15:53:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:53:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:11 INFO - no previously-included directories found matching 'docs/_build' 15:53:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:53:11 INFO - Running setup.py install for pep8 15:53:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:53:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:53:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:53:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:53:11 INFO - no previously-included directories found matching 'docs/_build' 15:53:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:53:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:53:11 INFO - Cleaning up... 15:53:11 INFO - Return code: 0 15:53:11 INFO - Running post-action listener: _resource_record_post_action 15:53:11 INFO - Running post-action listener: _start_resource_monitoring 15:53:11 INFO - Starting resource monitoring. 15:53:11 INFO - ##### 15:53:11 INFO - ##### Running install step. 15:53:11 INFO - ##### 15:53:11 INFO - Running pre-action listener: _resource_record_pre_action 15:53:11 INFO - Running main action method: install 15:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:11 INFO - Reading from file tmpfile_stdout 15:53:11 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:12 INFO - Reading from file tmpfile_stdout 15:53:12 INFO - Output received: 15:53:12 INFO - Usage: mozinstall [options] installer 15:53:12 INFO - Options: 15:53:12 INFO - -h, --help show this help message and exit 15:53:12 INFO - -d DEST, --destination=DEST 15:53:12 INFO - Directory to install application into. [default: 15:53:12 INFO - "/builds/slave/test"] 15:53:12 INFO - --app=APP Application being installed. [default: firefox] 15:53:12 INFO - mkdir: /builds/slave/test/build/application 15:53:12 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'] 15:53:12 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 15:53:25 INFO - Reading from file tmpfile_stdout 15:53:25 INFO - Output received: 15:53:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:53:25 INFO - Running post-action listener: _resource_record_post_action 15:53:25 INFO - ##### 15:53:25 INFO - ##### Running run-tests step. 15:53:25 INFO - ##### 15:53:25 INFO - Running pre-action listener: _resource_record_pre_action 15:53:25 INFO - Running main action method: run_tests 15:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:53:25 INFO - Python 2.7.3 15:53:25 INFO - Return code: 0 15:53:25 INFO - grabbing minidump binary from tooltool 15:53:25 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')]} 15:53:25 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 0x2d08410>, '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 0x2d09310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d097a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:53:25 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 15:53:25 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 15:53:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:53:25 INFO - Return code: 0 15:53:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:53:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:53:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:53:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:53:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:53:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:53:26 INFO - Return code: 0 15:53:26 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/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 15:53:26 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/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 15:53:26 INFO - Using env: {'DISPLAY': ':0', 15:53:26 INFO - 'HOME': '/home/cltbld', 15:53:26 INFO - 'LANG': 'en_US.UTF-8', 15:53:26 INFO - 'LANGUAGE': 'en_US:en', 15:53:26 INFO - 'LOGNAME': 'cltbld', 15:53:26 INFO - 'MAIL': '/var/mail/cltbld', 15:53:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:53:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:26 INFO - 'MOZ_NO_REMOTE': '1', 15:53:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:26 INFO - 'NO_EM_RESTART': '1', 15:53:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:26 INFO - 'PWD': '/builds/slave/test', 15:53:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:53:26 INFO - 'SHELL': '/bin/bash', 15:53:26 INFO - 'SHLVL': '1', 15:53:26 INFO - 'TERM': 'linux', 15:53:26 INFO - 'TMOUT': '86400', 15:53:26 INFO - 'USER': 'cltbld', 15:53:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733', 15:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:26 INFO - '_': '/tools/buildbot/bin/python'} 15:53:26 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/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 15:53:26 INFO - mozversion application_buildid: 20160629130426 15:53:26 INFO - mozversion application_changeset: ee43fafecf41bc2048b100e1fe2e272144884d19 15:53:26 INFO - mozversion application_display_name: Firefox 15:53:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:53:26 INFO - mozversion application_name: Firefox 15:53:26 INFO - mozversion application_remotingname: firefox 15:53:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:53:26 INFO - mozversion application_vendor: Mozilla 15:53:26 INFO - mozversion application_version: 48.0 15:53:26 INFO - mozversion platform_buildid: 20160629130426 15:53:26 INFO - mozversion platform_changeset: ee43fafecf41bc2048b100e1fe2e272144884d19 15:53:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:53:26 INFO - mozversion platform_version: 48.0 15:53:26 INFO - using testdate: 1467240806 15:53:26 INFO - actual date: 1467240806 15:53:26 INFO - starting webserver on 'localhost:60757' 15:53:26 INFO - SUITE-START | Running 2 tests 15:53:26 INFO - TEST-START | dromaeo_css 15:53:26 INFO - operating with platform_type : linux_ 15:53:26 INFO - Initialising browser for dromaeo_css test... 15:53:26 INFO - TEST-INFO | started process 4079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXARraT/profile http://localhost:60757/getInfo.html) 15:53:30 INFO - PROCESS | 4079 | 15:53:30 INFO - PROCESS | 4079 | (process:4158): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:53:31 INFO - PROCESS | 4079 | __metrics Screen width/height:1600/1200 15:53:31 INFO - PROCESS | 4079 | colorDepth:24 15:53:31 INFO - PROCESS | 4079 | Browser inner width/height: 1024/697 15:53:31 INFO - PROCESS | 4079 | __metrics 15:53:31 ERROR - PROCESS | 4079 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:53:32 INFO - TEST-INFO | 4079: exit 0 15:53:32 INFO - Browser initialized. 15:53:32 INFO - Running cycle 1/1 for dromaeo_css test... 15:53:32 INFO - TEST-INFO | started process 4208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXARraT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:53:34 INFO - PROCESS | 4208 | 15:53:34 INFO - PROCESS | 4208 | (process:4276): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:53:44 INFO - PROCESS | 4208 | RSS: Main: 150667264 15:53:44 INFO - PROCESS | 4208 | 15:54:34 INFO - PROCESS | 4208 | 1467240874061 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] 15:56:41 INFO - PROCESS | 4208 | Cycle 1(1): loaded http://localhost:60757/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60757/tests/dromaeo/cssquery-ext.html) 15:56:42 INFO - PROCESS | 4208 | RSS: Main: 154882048 15:56:42 INFO - PROCESS | 4208 | 15:59:44 INFO - PROCESS | 4208 | Cycle 1(1): loaded http://localhost:60757/tests/dromaeo/cssquery-ext.html (next: http://localhost:60757/tests/dromaeo/cssquery-jquery.html) 15:59:44 INFO - PROCESS | 4208 | RSS: Main: 152711168 15:59:44 INFO - PROCESS | 4208 | 16:02:46 INFO - PROCESS | 4208 | Cycle 1(1): loaded http://localhost:60757/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60757/tests/dromaeo/cssquery-mootools.html) 16:02:47 INFO - PROCESS | 4208 | RSS: Main: 152461312 16:02:47 INFO - PROCESS | 4208 | 16:05:48 INFO - PROCESS | 4208 | Cycle 1(1): loaded http://localhost:60757/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60757/tests/dromaeo/cssquery-prototype.html) 16:05:49 INFO - PROCESS | 4208 | RSS: Main: 154144768 16:05:49 INFO - PROCESS | 4208 | 16:08:51 INFO - PROCESS | 4208 | Cycle 1(1): loaded http://localhost:60757/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60757/tests/dromaeo/cssquery-yui.html) 16:08:52 INFO - PROCESS | 4208 | RSS: Main: 152510464 16:08:52 INFO - PROCESS | 4208 | 16:11:54 INFO - PROCESS | 4208 | Cycle 1(1): loaded http://localhost:60757/tests/dromaeo/cssquery-yui.html (next: http://localhost:60757/tests/dromaeo/cssquery-dojo.html) 16:11:54 INFO - PROCESS | 4208 | RSS: Main: 156377088 16:11:54 INFO - PROCESS | 4208 | 16:11:54 INFO - PROCESS | 4208 | __start_tp_report 16:11:54 INFO - PROCESS | 4208 | _x_x_mozilla_page_load 16:11:54 INFO - PROCESS | 4208 | _x_x_mozilla_page_load_details 16:11:54 INFO - PROCESS | 4208 | |i|pagename|runs| 16:11:54 INFO - PROCESS | 4208 | |0;dojo.html;3263.4125857345675;3334.8332583370825;3346.514755360471;3382.7293816494685;3394.473856552234;5489.34127904652;5532.761345451099;5568.248286481324;5590.972045139773;5622.156676498527;5536.280283563131;5543.556515478762;5549.056660367737;5561.221428999943;5579.302587176603;4969.155243608595;4988.226824842146;4992.750362481879;5044.066847633199;5055.090083784918;4987.975060124712;5061.139606266944;5098;5115.2071428928575;5139.640225184238;5033.647644664875;5052.520010598987;5083.567896728782;5146.305248791403;5149.74251287436;5066.569341605968;5086.92369614456;5094.108531007059;5100;5132.127538318495;4915.188993816016;4960.776765045545;4977.576905962997;5007.198848184309;5019.247112933052;5366.624336296461;5404.378496472917;5413.566914646819;5416.458354164592;5428.430014848463;5783.190353350535;5836.416358364172;5837.9124313135335;5841.065429531254;5857.560682948796;5902.468777810018;5935.080062590306;5951.315598706117;5958.6424814511265;5977.8804423911715;5488.945110548883;5518;5526.585506087019;5527.806526771584;5530.032244357221;5859.853503662357;6034.849128771728;6037.818865434044;6040.697965101727;6049.364816694184;5755.395683453261;5829.921464529076;5837.211976383219;5841.007028805113;5846.736896839652;5925.111233315038;5930.55520835939;5947.137665038632;5950.315713692894;5952.255968003999;5741.311042674905;5786.855328616818;5909.527237820964;5914.8817023659285;5917.733701983335;5896.7936122235515;5907.025340818716;5919.200907877382;5939.970300148471;5962.314333851663;4491.977540112279;4493.618042466427;4506.729596224237;4507.481639611421;4537.818487260539;3953.486046813953;4019.0354314964784;4061.3298805696727;4073.7759423232005;4093.713440059167;5511.145772405283;5647.068233741386;5695.03184458643;5717.685527296038;5739.885202295931;5861.941380586225;5911.586188966817;5917.556183286185;5926.585139040312;5927.881442371215;5634.098544232903;5676.914846277309;5707.571932105108;5719.142128680731;5743.569232307594;4926.605871530269;4994.2508623706735;5009.874753131201;5021.372328458942;5029.170186919117;6101.969490152521;6171.876562468726;6174.9073763892675;6180.505559555225;6203.286622038433;5910;5943.940560594425;5984.311804142405;6018.849528761816;6041.697915104315;6194.194754681863;6221.502279817694;6230.127782110599;6236.688165591611;6243.219597550306;5618.887622247614;5867.149263356875;5869.8239052828485;5869.911951320819;5901.822945311647;5909.734061967136;5963.9105413417965;5972.13404056418;5988.28140623128;6001.549883758648;5813.128030795415;5825.70871456434;5833.912491312719;5845.941540584539;5863.296404431496;5582.358028826737;5669.20631111653;5822.0684690449325;5826.592138550261;5832.737526811219;5675.460831221028;5707.486326230659;5712.34308054579;5714.971425142848;5725.312962444534;5720.199172115824;5768.077107662753;5770.336411312753;5784.305883294031;5813.534917206529;5538.778448862162;5694.345150307768;5740.827775166752;5746.569007324551;5760.279965004374 16:11:54 INFO - PROCESS | 4208 | |1;ext.html;668.5687731413238;673.2257903411077;677.3835809413434;726.0198731712189;744.9459015493078;31714.524282135786;32862.17844553888;39820.40269395958;40225.7988710056;40760;43218.56781432185;43695.56304436955;43739.56260437395;43813;43848.3422748659;8747.868781968276;8922.241609463203;8945.373823832335;8947.239484643813;8951.686690965818;8764.342674299422;8868.911310886873;8870.201681848632;8881.600327985256;8901.554922253894;8874.112588741138;9218.86171707425;9222.262219022463;9228.6308547658;9250.491222982733;9078.092190780935;9136.771580710469;9154.542272886329;9155.267578593697;9162.221211197057;8952.8657070144;9055.320850936207;9068.183863452256;9076.319276054322;9077.183053525148;43212;43698.34452483215;43707.34438983418;43730.562694372966;43843.12313753739;3954.3277642800795;4004.0590461241586;4026.8993275168064;4148.771817550033;4643.141018911479;31869.84065079683;32437;32661;33226.833865830515;33847.32305353904;4541.067106220588;4642.094791515656;4643.489216186217;4649.628029757611;4652.930206046912;317340;317403.9999999977;318074;318943;319784;60636;61071.38928610746;61113.69443152756;61122.694386527786;61260.693696531234;69003.30996690069;69359.30640693528;69385.30614693789;69389;69409.3059069413;17692.29230830778;17788.644227115645;17816.821831781777;17833.732494012602;17858.464246072377;15477.845221547866;15540.922295388451;15560.22198890051;15615.297311620778;15616.297266623029;20788;20879.373618791462;21078.156873724878;21111.155553777982;21231.36305910825;7640.121386040565;7717.961410192913;7718.92281077182;7895.539325224851;8087.797805054803;1171.3499008050444;1175.2830773228325;1220.5544976083843;1232.383808095952;1255.4789762248747;32552.53513591894;32879.741031018086;32952.505712414335;33181.17047073843;33966.83016584901;1189.1378750405886;1234.7160153164823;1283.5956673647959;1314.78963365861;1369.383777300219;17212.741808872877;17214;17263.482095537154;17492.300307987538;17660.381886633906;503724;558351;912783;917923;926213;61237.38762612406;62774.686126569075;62974.68512657408;63219.367806321345;63270.683646582394;1534.5549790560835;1537.8846586506056;1544.4208421841809;1557.128008315347;1613.7175994201202;32714.34571308608;32940.341193175525;33445.66554334426;33752.32495350128;34222.82888585541;54035.729821350644;54804.45195547993;54876;54895.72552137214;55015.44984550103;441060;445568;445806;446242;446421;30792;30809.229769255948;31245.687543125186;31262.37475250528;31419.214519636276;49020.509794903024;49233.507664922894;49444.50555494543;49477.25784113169;50172.498275016784;39297;41257.58742412538;41694;42286;42702;40849.59150408458;41164.176716464906;41294.1741165169;41410.37884431676;41533.169336613704;42194.156116876875;44368.778156109016;44613.776931115135;44830;45764.31353529633;35046;35264.647353527165;35609.64390356063;36180.27639447249;36261.27477450489;28882.855585722777;29093.272668183465;29113.563296550146;29522.704772951995;29534.852325738233 16:11:54 INFO - PROCESS | 4208 | |2;jquery.html;417.29893778452185;421.69005780751144;424.7960978730209;425.11151692961704;428.26338697440394;18579.163937622805;19318.227270909163;19370.128344224508;19677.70483442746;20729.274475393366;19520.90239548804;19723.1124599393;20121.396358109243;20391.796082039175;20541.4864628384;5540.335159780832;5555.444455554442;5808.506276966442;5809.477147056764;5828.125781132842;5706.77172913083;5719.656820590778;5752.539796816265;5761.423857614226;5794.768209271624;5563.777448902059;5677.48902598766;5725.370209276997;5738.713064346766;5763.9711801440935;5614.382417934024;5618.662880227179;5629.380768115504;5641.26663533738;5658.74535645897;5080.187170052774;5110.233464980245;5123.359580052494;5483.232347471358;5739.885202295973;14410.351534180987;14679.706405871822;14692.191929443876;15567.688646227012;23206.65190022151;2474.8020158387285;2475.8724195167692;2533.442642618621;2576.9098081567054;2617.3718307606227;10146.644867429604;10313.226508011854;10421.27051106423;10436.37381757097;10457;1958.2069261948934;2026.0882602828785;2104.5054412213117;2121.7666056733747;2147.9892600537055;81374.59312703398;83694.74457883197;85144;86042;86567.56716216441;11123;11473.368964706855;11513.30920144794;12089.03287736979;12356.073294502768;15918.602034948988;16010.439634612732;16131.112788796494;16224.432144875109;16274.104924229045;8665.13348665141;8926.419782714103;9154.947181074129;9242.630294788267;9246.76883077915;8986.236169925629;9026.86459703105;9054.81890362189;9059.637614495346;9249.260059195249;4947;4955;4975.577075948512;4986.975065124724;5037.0681423936685;2008.8292495138078;2035.6641154209685;2064.576761763865;2073.7822528634274;2122.5754849029945;1047.586203449633;1077.7952189084049;1095.8301463273046;1118.1502058435647;1143.9656810295537;18359.265629374942;18587.44237672872;18817.15322810477;19107.522311942314;19324.1304141314;1050.9001644843727;1079.2351766948832;1124.7019539821954;1132.8867113288604;1194.707296712311;10653.680389588324;10704.1436685065;10807.945960270148;10839.783204335869;10901.618443354444;566230;579552;616417;635996;642165;73869;86560;87049.56475217584;102247;103765;1168.6026750904732;1171.7832201042834;1176.4411904345368;1207.3540655749132;1231.5751065882257;17241.431005791404;17555.297788088843;17723.025233612276;17805.46583602494;18003.2798688051;41593.1681366377;41994.74015779531;42043.789781052124;42518.78740606277;42597.78701106475;61204.69397652983;61913;62781.37218627755;62976.68511657596;63142.368576313645;8743.169398907094;8897.866532002156;8972.955135224282;9015.909840901508;9218.308626853148;12445;13078.346082696018;13348.866511334762;13512.459501620218;14004.719905602034;11773.764524709286;12037.217580857216;12176.634700958986;12354.814677780021;12557.93721031389;12214.450349734105;12244.142909996215;12390.132690711924;12419.689507762378;12743.426545805647;12319.384030798603;12963.740725185633;13181.736365272833;13220.206787592775;13334.133281336683;9225.308101892251;9346.813063738824;9430.387024843363;9438.150566449052;9541.236701064037;12219.69450763738;12457.626271211879;12694.492220311453;12873;12886.67783305425 16:11:54 INFO - PROCESS | 4208 | |3;mootools.html;1571.7878086458327;1594.481793417139;1780.9554761130971;1877.1740434208955;1902.134528789401;7497.625118744055;8016.799580010488;8282.62728177232;8455.154484551542;8487.854139691131;7865.724699635514;8081.313088387479;8091.2717855393;8322.33421326294;8411.789705257372;2483.739207383221;2502.612095125249;2504.9749502505015;2525.4570267392505;2526.608375701769;2486.477839653675;2542.2881593153948;2552.1960582416573;2553.195743340851;2553.3871870750977;2489.514544663791;2499.462615537659;2500.812439067068;2503.7120731115883;2515.5220508103403;2498.750124987496;2500.8749562521803;2514.120057979711;2514.8994040238554;2520.117958714454;2504;2523.6088406297054;2532.3162746058647;2535.7083935347487;2550.0309882244815;8634.136586341378;8673.262772664331;8694.043655197924;8695.130486951255;8708.695195668184;5402.486763757437;5524.14375771752;5570.359408668014;5571.804986825482;5576.0241957657245;3560.12776869666;3581.247937933037;3604.873829415984;3715.4055351143957;3729.1236559408517;1185.875483074282;1189.9464524096436;1218.7745267125522;1223.2354778263584;1247.7566874459485;11770.41147942608;11811.704707382298;11832.526698932032;11857.525698972031;11872.465739041678;4598.195315819718;4630.791614377361;4661.557152070548;4685.250359942393;4690.89763905482;9415.90584094164;9418.529073546295;9420.057994200524;9457.29070319715;9462.43225406464;5376.1398176291605;5395.487428694268;5400.108982017923;5401.378841433207;5423.322084739408;4967.254911763264;5051.545360917535;5071.2139618359215;5092.032513822362;5093.668911520739;3949.7037722170376;3972.841086356513;4048.39274108886;4097.487814023247;4133.152703695795;1207.3419986107417;1208.4501551793912;1216.7505661339403;1219.5182902753363;1235.610782603477;1081.3349789879326;1087.374759513283;1095.2661716649864;1098.6429410441638;1120.9439528023565;5894.970525147432;5954.10688396744;5975.910361344583;6033.728482218311;6055.545834062463;469.567997442347;470.6752340884847;471.59442879123924;1122.7586068995206;1136.9653615210118;4129.8967525812095;4156.127213285244;4176.14389050244;4197.538270790211;4309.698321117492;9954.153896918842;10121.69634910954;10216.233782466345;10240.283180177315;10290.176785857113;10039.648612298535;10073.49632518371;10079.143272821892;10135.442550659636;10139.391636501834;7725.536467811837;8011.319037881729;8128.634211460499;8141.552214628134;8146.918530814734;5899.351071382231;5961.791337303347;5971.223740913653;5988.28140623128;6087.786927457518;8872.955635221782;8924.776880578038;8926.509042002752;8992.190702836777;9001.459912405277;9034.909650903406;9476.763080922756;9568.904310956801;9639.132478077006;9712.70861874145;6600.07598936159;7150.356467917913;7328.523645963209;7372.631368431665;7432.3310902019075;7978.481398709066;8006.91993080085;8022.679092836222;8033.076196237507;8045.477043992122;7197.676104575411;7320.121585409572;7406.629668516445;7453.850922981618;7496.437767167376;7177.569345839266;7218.169910460154;7227.27727227273;7254.202037775735;7310.378617817332;6904.206016308189;6909;6913.51605387618;6955.061066755923;6983.266756990442;5082.652857996356;5198.435992080391;5247.507433968834;5347;5369.033573956569;5278.97360513195;5295.099833028471;5334.3865455473115;5422.8373148805595;5424.620276580601 16:11:54 INFO - PROCESS | 4208 | |4;prototype.html;338.10739647331053;350.34135824649655;351.28162906855476;358.8421094718324;360.23629904602245;6559.967200163998;6573.638449885254;6672.366125218108;6688.331166883316;6709.127813384265;6533.575317604353;6564.212294524652;6568.934310656892;6577.046328282396;6585;4745.050989802045;4899.167141585939;4923.70457772533;4927.901441971158;4935.0376676548085;4906.5093490650825;4912.091263116317;4917.065757506062;4925.162722337212;4932.186189278765;4866.391701037371;4887.1447496688115;4890.462049174588;4896.216605343146;4897.730624815652;4890.119778439879;4900;4900.509949005089;4902.313676085351;4910.288008238821;4236.978815105905;4237.7669228192435;4239.0674051708575;4241.957580424187;4249.128928569667;6179.81460556184;6280.811575652738;6316.210473690789;6326.177596912418;6336.398042185985;5669.092945128801;5718.313802343745;5720.11338242573;5724.341700704431;5724.513416359614;6899.241083480813;6903.792886213421;6909.136357955255;6920.342567456134;6923.065386172903;4693.507181745902;4699.295105734167;4702.177119004161;4705.882352941169;4717.858464246078;7184.497085204038;7189.245129261457;7205.423566114699;7250.3112204340505;7257.983882256488;4667.32323813052;4746.311784791186;4770.260609605517;4786.521347865186;4787.4494433139935;4827.662063655511;4851.684640498356;4855.490173531799;4862.07620552094;4864.124457597666;5670.688112153789;5671.319441666944;5678.290213723285;5680.375158732536;5689.459501347365;6929.653517324215;6963.8607227855155;6987.1266091738535;6999.51003429755;6999.510034297652;1688.856447201977;1714.9657006859793;1716.21054315014;1716.3392094043634;1725.387487441965;1049.338916482611;1103.0568863621488;1117.3072694929033;1123.2474242257706;1124.100719424457;6796.626185559743;6814.454843612499;6815.795526134125;6823.829404264933;6824.863502730017;7180.640967951582;7199.06412166415;7199.280071992864;7223.674934627954;7248.0939882514685;6669.333066693292;6786.660666966731;6879.449644028466;6883.586984780929;6890.724371025203;3892.824822882977;3897.0452239201577;3897.415387691869;3930.862419815293;3942.9014274643364;7608.391328693691;7608.923910760932;7617.619119044026;7620.695172193161;7628.656710448043;7282.70869165238;7375.926240737524;7417.740379086706;7417.888731669029;7428.85142297151;7589.089309282811;7598.20218877021;7608.277213664804;7612.7716168515035;7623.856421536814;7203.963980180066;7225.205227424874;7243.058402407653;7252.818679533054;7258.49190556656;7118.466115041496;7126;7131.286871312827;7134.750283740044;7148.785536433916;7432.516886402366;7552.773416797505;7586.165521792488;7603.239676032574;7629.847403052019;4776.307435421775;4811.927821082757;4820.1805693031565;4838.8790280241865;4845.442774080885;7206.459515536251;7254.96372518134;7256.637168141678;7279.818004549928;7280.781576552712;7003.159620845531;7011.789646310619;7015.859682806417;7027.648617569203;7038.331358520933;6862.245153033262;7003;7011.789646310619;7032.472564557781;7051.823704407431;6870.793876183722;6890.31096890307;6890.655467226718;6894.655267236719;6908.758193463204;7036.859262814817;7054.153501579844;7068.222495525385;7069.681864316015;7077.327653872874;6880.105586273752;6888.483363747639;6894.8621027580175;6895.75864844728;6902.792916212522 16:11:54 INFO - PROCESS | 4208 | |5;yui.html;922.4557511068471;930.6137952749609;933.5052422216223;937.8265020971119;953.828310904037;14784.408623655054;14902.627434314147;14951.327190276437;14958.626034349147;15077;14245.786313205284;14550.345234464448;14557;14561;14698.559043228694;748.0275641665839;901.1529162587179;908.2280061947358;909.9444644212715;934.6354921580589;924.7780532672177;928.2759447630825;928.8095940332249;928.9117533834309;930.1210356213347;966.2656381150341;967.5549247346229;971.7376308396729;972.4019727867346;976;961.0821665309647;961.3366776923936;961.4471678784657;962.6390103711109;963.0802583532709;707.762899428692;708.9858202835966;710.8400609862791;711.7829062136046;712.7256006437507;14258.358373873201;14271.00102992791;14360.856391436057;14365.281735913162;14365.856341436556;14298.142111473346;14384.424623015171;14406.351714172888;14526.34631441577;14794.926025369912;11997.94001029998;12112.636620901387;12232.571859984857;12274;12297.69255768604;4061.634452899253;4064.3497040473676;4074.7351422157762;4097.795110244506;4106.527749308838;54549;55423.72288138574;55766.44233557653;55876;56012.15981760277;11806.88193118075;12050.156489045683;12052.638420847388;12178.878211217952;12189.451474683661;21880.78119218819;21902.890485547472;21904;21906;21921.671174932388;8586.742397728078;8609.698660546976;8676.219140277406;8746.912530874737;8773;4889.437714662859;4954.9752251238515;4955.4548999610015;4956.801727930914;4979.975100124476;3462.5498685170764;3484.5992710838073;3488.581370235537;3515.5781306243416;3525.7355698322726;578.7222133376004;628.3465196195997;640.1645852162972;644.7453255963868;645.1097485470021;765.689895592286;826.7065191856924;840.206005324962;840.369722707969;867.2584939876441;9242.907570924339;9396.859047114298;9467.952660236793;9485.098915603006;9581.089796469325;728.559221670892;801.555136899015;817.1093508076107;833.9749807505784;834.5660256666499;4357.411749413852;4494.325851122292;4545.909081818411;4631.3516107744945;4751.976240118777;60963.695181524694;61020.69489652523;61431.69284153551;61573;67581.66209168923;54210.45789542133;54379.45620543744;54868.45131548633;54984.725076374365;55486;49265.014699705804;49554.1337598719;49903.50096499061;49913.75043124761;49921.251181231586;9987.750306242402;10118.19054475655;10187.235957303084;10248.795024099625;10345;36910;37062.814685926394;37917;38459.61540384672;38541.2291754169;45526.317105242786;45715.77142114268;47515;47808.76095619639;47813.28280075732;12050.156489045683;12703.42834572465;12805.551805686757;12877.034222433542;13009.869901300866;13779.242141682304;14035.438582456996;14103.435862565382;14152.292385380484;14221.715565688835;12504.312262825631;12631.431585578855;12727.809082863949;12963.546275880299;13471.595852124452;13048.804267935799;13139.868601314247;13174.275414852274;13401.262930538915;13462.528811491551;12355.75288494243;12714.300713460849;13044.152130111512;13122.409491572711;13349.466021359036;10644.89355106439;10813.513391897226;10945.83581246266;11039.668809935714;11058.889411106107;11340.489677964677;11359.261647992855;11565.942170289094;11572.710682233012;11701.590444334408 16:11:54 INFO - PROCESS | 4208 | __end_tp_report 16:11:54 INFO - PROCESS | 4208 | __start_cc_report 16:11:54 INFO - PROCESS | 4208 | _x_x_mozilla_cycle_collect,322 16:11:54 INFO - PROCESS | 4208 | __end_cc_report 16:11:54 INFO - PROCESS | 4208 | __startTimestamp1467241914633__endTimestamp 16:11:54 INFO - PROCESS | 4208 | 16:11:54 INFO - PROCESS | 4208 | ------- Summary: start ------- 16:11:54 INFO - PROCESS | 4208 | Number of tests: 6 16:11:54 INFO - PROCESS | 4208 | 16:11:54 INFO - PROCESS | 4208 | [#0] dojo.html Cycles:165 Average:5505.90 Median:5720.20 stddev:614.28 (10.7%) stddev-sans-first:590.44 16:11:54 INFO - PROCESS | 4208 | Values: 3263.4 3334.8 3346.5 3382.7 3394.5 5489.3 5532.8 5568.2 5591.0 5622.2 5536.3 5543.6 5549.1 5561.2 5579.3 4969.2 4988.2 4992.8 5044.1 5055.1 4988.0 5061.1 5098.0 5115.2 5139.6 5033.6 5052.5 5083.6 5146.3 5149.7 5066.6 5086.9 5094.1 5100.0 5132.1 4915.2 4960.8 4977.6 5007.2 5019.2 5366.6 5404.4 5413.6 5416.5 5428.4 5783.2 5836.4 5837.9 5841.1 5857.6 5902.5 5935.1 5951.3 5958.6 5977.9 5488.9 5518.0 5526.6 5527.8 5530.0 5859.9 6034.8 6037.8 6040.7 6049.4 5755.4 5829.9 5837.2 5841.0 5846.7 5925.1 5930.6 5947.1 5950.3 5952.3 5741.3 5786.9 5909.5 5914.9 5917.7 5896.8 5907.0 5919.2 5940.0 5962.3 4492.0 4493.6 4506.7 4507.5 4537.8 3953.5 4019.0 4061.3 4073.8 4093.7 5511.1 5647.1 5695.0 5717.7 5739.9 5861.9 5911.6 5917.6 5926.6 5927.9 5634.1 5676.9 5707.6 5719.1 5743.6 4926.6 4994.3 5009.9 5021.4 5029.2 6102.0 6171.9 6174.9 6180.5 6203.3 5910.0 5943.9 5984.3 6018.8 6041.7 6194.2 6221.5 6230.1 6236.7 6243.2 5618.9 5867.1 5869.8 5869.9 5901.8 5909.7 5963.9 5972.1 5988.3 6001.5 5813.1 5825.7 5833.9 5845.9 5863.3 5582.4 5669.2 5822.1 5826.6 5832.7 5675.5 5707.5 5712.3 5715.0 5725.3 5720.2 5768.1 5770.3 5784.3 5813.5 5538.8 5694.3 5740.8 5746.6 5760.3 16:11:54 INFO - PROCESS | 4208 | 16:11:54 INFO - PROCESS | 4208 | [#1] ext.html Cycles:180 Average:66925.61 Median:43215.28 stddev:148985.44 (344.8%) stddev-sans-first:149320.33 16:11:54 INFO - PROCESS | 4208 | Values: 668.6 673.2 677.4 726.0 744.9 31714.5 32862.2 39820.4 40225.8 40760.0 43218.6 43695.6 43739.6 43813.0 43848.3 8747.9 8922.2 8945.4 8947.2 8951.7 8764.3 8868.9 8870.2 8881.6 8901.6 8874.1 9218.9 9222.3 9228.6 9250.5 9078.1 9136.8 9154.5 9155.3 9162.2 8952.9 9055.3 9068.2 9076.3 9077.2 43212.0 43698.3 43707.3 43730.6 43843.1 3954.3 4004.1 4026.9 4148.8 4643.1 31869.8 32437.0 32661.0 33226.8 33847.3 4541.1 4642.1 4643.5 4649.6 4652.9 317340.0 317404.0 318074.0 318943.0 319784.0 60636.0 61071.4 61113.7 61122.7 61260.7 69003.3 69359.3 69385.3 69389.0 69409.3 17692.3 17788.6 17816.8 17833.7 17858.5 15477.8 15540.9 15560.2 15615.3 15616.3 20788.0 20879.4 21078.2 21111.2 21231.4 7640.1 7718.0 7718.9 7895.5 8087.8 1171.3 1175.3 1220.6 1232.4 1255.5 32552.5 32879.7 32952.5 33181.2 33966.8 1189.1 1234.7 1283.6 1314.8 1369.4 17212.7 17214.0 17263.5 17492.3 17660.4 503724.0 558351.0 912783.0 917923.0 926213.0 61237.4 62774.7 62974.7 63219.4 63270.7 1534.6 1537.9 1544.4 1557.1 1613.7 32714.3 32940.3 33445.7 33752.3 34222.8 54035.7 54804.5 54876.0 54895.7 55015.4 441060.0 445568.0 445806.0 446242.0 446421.0 30792.0 30809.2 31245.7 31262.4 31419.2 49020.5 49233.5 49444.5 49477.3 50172.5 39297.0 41257.6 41694.0 42286.0 42702.0 40849.6 41164.2 41294.2 41410.4 41533.2 42194.2 44368.8 44613.8 44830.0 45764.3 35046.0 35264.6 35609.6 36180.3 36261.3 28882.9 29093.3 29113.6 29522.7 29534.9 16:11:54 INFO - PROCESS | 4208 | 16:11:54 INFO - PROCESS | 4208 | [#2] jquery.html Cycles:180 Average:32583.40 Median:11401.53 stddev:99905.11 (876.2%) stddev-sans-first:100156.17 16:11:54 INFO - PROCESS | 4208 | Values: 417.3 421.7 424.8 425.1 428.3 18579.2 19318.2 19370.1 19677.7 20729.3 19520.9 19723.1 20121.4 20391.8 20541.5 5540.3 5555.4 5808.5 5809.5 5828.1 5706.8 5719.7 5752.5 5761.4 5794.8 5563.8 5677.5 5725.4 5738.7 5764.0 5614.4 5618.7 5629.4 5641.3 5658.7 5080.2 5110.2 5123.4 5483.2 5739.9 14410.4 14679.7 14692.2 15567.7 23206.7 2474.8 2475.9 2533.4 2576.9 2617.4 10146.6 10313.2 10421.3 10436.4 10457.0 1958.2 2026.1 2104.5 2121.8 2148.0 81374.6 83694.7 85144.0 86042.0 86567.6 11123.0 11473.4 11513.3 12089.0 12356.1 15918.6 16010.4 16131.1 16224.4 16274.1 8665.1 8926.4 9154.9 9242.6 9246.8 8986.2 9026.9 9054.8 9059.6 9249.3 4947.0 4955.0 4975.6 4987.0 5037.1 2008.8 2035.7 2064.6 2073.8 2122.6 1047.6 1077.8 1095.8 1118.2 1144.0 18359.3 18587.4 18817.2 19107.5 19324.1 1050.9 1079.2 1124.7 1132.9 1194.7 10653.7 10704.1 10807.9 10839.8 10901.6 566230.0 579552.0 616417.0 635996.0 642165.0 73869.0 86560.0 87049.6 102247.0 103765.0 1168.6 1171.8 1176.4 1207.4 1231.6 17241.4 17555.3 17723.0 17805.5 18003.3 41593.2 41994.7 42043.8 42518.8 42597.8 61204.7 61913.0 62781.4 62976.7 63142.4 8743.2 8897.9 8973.0 9015.9 9218.3 12445.0 13078.3 13348.9 13512.5 14004.7 11773.8 12037.2 12176.6 12354.8 12557.9 12214.5 12244.1 12390.1 12419.7 12743.4 12319.4 12963.7 13181.7 13220.2 13334.1 9225.3 9346.8 9430.4 9438.2 9541.2 12219.7 12457.6 12694.5 12873.0 12886.7 16:11:54 INFO - PROCESS | 4208 | 16:11:54 INFO - PROCESS | 4208 | [#3] mootools.html Cycles:180 Average:5649.26 Median:5222.97 stddev:2991.55 (57.3%) stddev-sans-first:2984.25 16:11:54 INFO - PROCESS | 4208 | Values: 1571.8 1594.5 1781.0 1877.2 1902.1 7497.6 8016.8 8282.6 8455.2 8487.9 7865.7 8081.3 8091.3 8322.3 8411.8 2483.7 2502.6 2505.0 2525.5 2526.6 2486.5 2542.3 2552.2 2553.2 2553.4 2489.5 2499.5 2500.8 2503.7 2515.5 2498.8 2500.9 2514.1 2514.9 2520.1 2504.0 2523.6 2532.3 2535.7 2550.0 8634.1 8673.3 8694.0 8695.1 8708.7 5402.5 5524.1 5570.4 5571.8 5576.0 3560.1 3581.2 3604.9 3715.4 3729.1 1185.9 1189.9 1218.8 1223.2 1247.8 11770.4 11811.7 11832.5 11857.5 11872.5 4598.2 4630.8 4661.6 4685.3 4690.9 9415.9 9418.5 9420.1 9457.3 9462.4 5376.1 5395.5 5400.1 5401.4 5423.3 4967.3 5051.5 5071.2 5092.0 5093.7 3949.7 3972.8 4048.4 4097.5 4133.2 1207.3 1208.5 1216.8 1219.5 1235.6 1081.3 1087.4 1095.3 1098.6 1120.9 5895.0 5954.1 5975.9 6033.7 6055.5 469.6 470.7 471.6 1122.8 1137.0 4129.9 4156.1 4176.1 4197.5 4309.7 9954.2 10121.7 10216.2 10240.3 10290.2 10039.6 10073.5 10079.1 10135.4 10139.4 7725.5 8011.3 8128.6 8141.6 8146.9 5899.4 5961.8 5971.2 5988.3 6087.8 8873.0 8924.8 8926.5 8992.2 9001.5 9034.9 9476.8 9568.9 9639.1 9712.7 6600.1 7150.4 7328.5 7372.6 7432.3 7978.5 8006.9 8022.7 8033.1 8045.5 7197.7 7320.1 7406.6 7453.9 7496.4 7177.6 7218.2 7227.3 7254.2 7310.4 6904.2 6909.0 6913.5 6955.1 6983.3 5082.7 5198.4 5247.5 5347.0 5369.0 5279.0 5295.1 5334.4 5422.8 5424.6 16:11:54 INFO - PROCESS | 4208 | 16:11:54 INFO - PROCESS | 4208 | [#4] prototype.html Cycles:180 Average:5820.13 Median:6747.89 stddev:1808.94 (26.8%) stddev-sans-first:1766.60 16:11:54 INFO - PROCESS | 4208 | Values: 338.1 350.3 351.3 358.8 360.2 6560.0 6573.6 6672.4 6688.3 6709.1 6533.6 6564.2 6568.9 6577.0 6585.0 4745.1 4899.2 4923.7 4927.9 4935.0 4906.5 4912.1 4917.1 4925.2 4932.2 4866.4 4887.1 4890.5 4896.2 4897.7 4890.1 4900.0 4900.5 4902.3 4910.3 4237.0 4237.8 4239.1 4242.0 4249.1 6179.8 6280.8 6316.2 6326.2 6336.4 5669.1 5718.3 5720.1 5724.3 5724.5 6899.2 6903.8 6909.1 6920.3 6923.1 4693.5 4699.3 4702.2 4705.9 4717.9 7184.5 7189.2 7205.4 7250.3 7258.0 4667.3 4746.3 4770.3 4786.5 4787.4 4827.7 4851.7 4855.5 4862.1 4864.1 5670.7 5671.3 5678.3 5680.4 5689.5 6929.7 6963.9 6987.1 6999.5 6999.5 1688.9 1715.0 1716.2 1716.3 1725.4 1049.3 1103.1 1117.3 1123.2 1124.1 6796.6 6814.5 6815.8 6823.8 6824.9 7180.6 7199.1 7199.3 7223.7 7248.1 6669.3 6786.7 6879.4 6883.6 6890.7 3892.8 3897.0 3897.4 3930.9 3942.9 7608.4 7608.9 7617.6 7620.7 7628.7 7282.7 7375.9 7417.7 7417.9 7428.9 7589.1 7598.2 7608.3 7612.8 7623.9 7204.0 7225.2 7243.1 7252.8 7258.5 7118.5 7126.0 7131.3 7134.8 7148.8 7432.5 7552.8 7586.2 7603.2 7629.8 4776.3 4811.9 4820.2 4838.9 4845.4 7206.5 7255.0 7256.6 7279.8 7280.8 7003.2 7011.8 7015.9 7027.6 7038.3 6862.2 7003.0 7011.8 7032.5 7051.8 6870.8 6890.3 6890.7 6894.7 6908.8 7036.9 7054.2 7068.2 7069.7 7077.3 6880.1 6888.5 6894.9 6895.8 6902.8 16:11:54 INFO - PROCESS | 4208 | 16:11:54 INFO - PROCESS | 4208 | [#5] yui.html Cycles:180 Average:15355.31 Median:4520.12 stddev:17286.44 (382.4%) stddev-sans-first:17300.96 16:11:54 INFO - PROCESS | 4208 | Values: 922.5 930.6 933.5 937.8 953.8 14784.4 14902.6 14951.3 14958.6 15077.0 14245.8 14550.3 14557.0 14561.0 14698.6 748.0 901.2 908.2 909.9 934.6 924.8 928.3 928.8 928.9 930.1 966.3 967.6 971.7 972.4 976.0 961.1 961.3 961.4 962.6 963.1 707.8 709.0 710.8 711.8 712.7 14258.4 14271.0 14360.9 14365.3 14365.9 14298.1 14384.4 14406.4 14526.3 14794.9 11997.9 12112.6 12232.6 12274.0 12297.7 4061.6 4064.3 4074.7 4097.8 4106.5 54549.0 55423.7 55766.4 55876.0 56012.2 11806.9 12050.2 12052.6 12178.9 12189.5 21880.8 21902.9 21904.0 21906.0 21921.7 8586.7 8609.7 8676.2 8746.9 8773.0 4889.4 4955.0 4955.5 4956.8 4980.0 3462.5 3484.6 3488.6 3515.6 3525.7 578.7 628.3 640.2 644.7 645.1 765.7 826.7 840.2 840.4 867.3 9242.9 9396.9 9468.0 9485.1 9581.1 728.6 801.6 817.1 834.0 834.6 4357.4 4494.3 4545.9 4631.4 4752.0 60963.7 61020.7 61431.7 61573.0 67581.7 54210.5 54379.5 54868.5 54984.7 55486.0 49265.0 49554.1 49903.5 49913.8 49921.3 9987.8 10118.2 10187.2 10248.8 10345.0 36910.0 37062.8 37917.0 38459.6 38541.2 45526.3 45715.8 47515.0 47808.8 47813.3 12050.2 12703.4 12805.6 12877.0 13009.9 13779.2 14035.4 14103.4 14152.3 14221.7 12504.3 12631.4 12727.8 12963.5 13471.6 13048.8 13139.9 13174.3 13401.3 13462.5 12355.8 12714.3 13044.2 13122.4 13349.5 10644.9 10813.5 10945.8 11039.7 11058.9 11340.5 11359.3 11565.9 11572.7 11701.6 16:11:54 INFO - PROCESS | 4208 | -------- Summary: end -------- 16:11:54 INFO - PROCESS | 4208 | 16:11:55 INFO - TEST-INFO | 4208: exit 0 16:11:55 INFO - TEST-OK | dromaeo_css | took 1108865ms 16:11:55 INFO - TEST-START | kraken 16:11:55 INFO - operating with platform_type : linux_ 16:11:55 INFO - Initialising browser for kraken test... 16:11:55 INFO - TEST-INFO | started process 4451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyd7Ehc/profile http://localhost:60757/getInfo.html) 16:11:59 INFO - PROCESS | 4451 | 16:11:59 INFO - PROCESS | 4451 | (process:4531): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:11:59 INFO - PROCESS | 4451 | __metrics Screen width/height:1600/1200 16:11:59 INFO - PROCESS | 4451 | colorDepth:24 16:11:59 INFO - PROCESS | 4451 | Browser inner width/height: 1024/697 16:11:59 INFO - PROCESS | 4451 | __metrics 16:12:00 ERROR - PROCESS | 4451 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 16:12:01 INFO - TEST-INFO | 4451: exit 0 16:12:01 INFO - Browser initialized. 16:12:01 INFO - Running cycle 1/1 for kraken test... 16:12:01 INFO - TEST-INFO | started process 4581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyd7Ehc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:03 INFO - PROCESS | 4581 | 16:12:03 INFO - PROCESS | 4581 | (process:4647): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:12:13 INFO - PROCESS | 4581 | RSS: Main: 150966272 16:12:13 INFO - PROCESS | 4581 | 16:12:15 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60757/tests/kraken/driver.html?testName=audio-beat-detection) 16:12:16 INFO - PROCESS | 4581 | RSS: Main: 156352512 16:12:16 INFO - PROCESS | 4581 | 16:12:19 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60757/tests/kraken/driver.html?testName=audio-dft) 16:12:19 INFO - PROCESS | 4581 | RSS: Main: 155766784 16:12:19 INFO - PROCESS | 4581 | 16:12:22 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60757/tests/kraken/driver.html?testName=audio-fft) 16:12:23 INFO - PROCESS | 4581 | RSS: Main: 156012544 16:12:23 INFO - PROCESS | 4581 | 16:12:25 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60757/tests/kraken/driver.html?testName=audio-oscillator) 16:12:26 INFO - PROCESS | 4581 | RSS: Main: 155992064 16:12:26 INFO - PROCESS | 4581 | 16:12:28 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60757/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:12:28 INFO - PROCESS | 4581 | RSS: Main: 156155904 16:12:28 INFO - PROCESS | 4581 | 16:12:31 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60757/tests/kraken/driver.html?testName=imaging-darkroom) 16:12:32 INFO - PROCESS | 4581 | RSS: Main: 156610560 16:12:32 INFO - PROCESS | 4581 | 16:12:35 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60757/tests/kraken/driver.html?testName=imaging-desaturate) 16:12:36 INFO - PROCESS | 4581 | RSS: Main: 156565504 16:12:36 INFO - PROCESS | 4581 | 16:12:39 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60757/tests/kraken/driver.html?testName=json-parse-financial) 16:12:39 INFO - PROCESS | 4581 | RSS: Main: 156438528 16:12:39 INFO - PROCESS | 4581 | 16:12:41 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60757/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:12:41 INFO - PROCESS | 4581 | RSS: Main: 156102656 16:12:41 INFO - PROCESS | 4581 | 16:12:43 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60757/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:12:44 INFO - PROCESS | 4581 | RSS: Main: 156565504 16:12:44 INFO - PROCESS | 4581 | 16:12:46 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60757/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:12:46 INFO - PROCESS | 4581 | RSS: Main: 156819456 16:12:46 INFO - PROCESS | 4581 | 16:12:49 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:12:50 INFO - PROCESS | 4581 | RSS: Main: 157114368 16:12:50 INFO - PROCESS | 4581 | 16:12:52 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:12:53 INFO - PROCESS | 4581 | RSS: Main: 156835840 16:12:53 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | Cycle 1(1): loaded http://localhost:60757/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60757/tests/kraken/driver.html?testName=ai-astar) 16:12:55 INFO - PROCESS | 4581 | RSS: Main: 158064640 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | __start_tp_report 16:12:55 INFO - PROCESS | 4581 | _x_x_mozilla_page_load 16:12:55 INFO - PROCESS | 4581 | _x_x_mozilla_page_load_details 16:12:55 INFO - PROCESS | 4581 | |i|pagename|runs| 16:12:55 INFO - PROCESS | 4581 | |0;ai-astar;109;110;104;109;112;111;101;112;112;111 16:12:55 INFO - PROCESS | 4581 | |1;audio-beat-detection;167;128;160;175;129;155;153;134;180;129 16:12:55 INFO - PROCESS | 4581 | |2;audio-dft;161;163;162;164;162;162;163;161;162;164 16:12:55 INFO - PROCESS | 4581 | |3;audio-fft;76;77;78;177;74;76;76;76;176;77 16:12:55 INFO - PROCESS | 4581 | |4;audio-oscillator;91;92;158;91;92;92;147;92;91;139 16:12:55 INFO - PROCESS | 4581 | |5;imaging-gaussian-blur;117;117;116;118;117;118;117;118;117;117 16:12:55 INFO - PROCESS | 4581 | |6;imaging-darkroom;147;147;146;146;147;147;146;146;147;146 16:12:55 INFO - PROCESS | 4581 | |7;imaging-desaturate;95;95;95;95;95;95;94;96;94;95 16:12:55 INFO - PROCESS | 4581 | |8;json-parse-financial;55;57;56;55;56;56;58;75;61;55 16:12:55 INFO - PROCESS | 4581 | |9;json-stringify-tinderbox;56;56;57;58;58;57;58;57;57;57 16:12:55 INFO - PROCESS | 4581 | |10;stanford-crypto-aes;82;75;74;78;82;75;75;75;75;75 16:12:55 INFO - PROCESS | 4581 | |11;stanford-crypto-ccm;120;127;115;113;116;123;126;117;129;140 16:12:55 INFO - PROCESS | 4581 | |12;stanford-crypto-pbkdf2;173;162;164;166;165;164;170;162;164;160 16:12:55 INFO - PROCESS | 4581 | |13;stanford-crypto-sha256-iterative;69;66;70;68;68;68;69;66;68;67 16:12:55 INFO - PROCESS | 4581 | __end_tp_report 16:12:55 INFO - PROCESS | 4581 | __start_cc_report 16:12:55 INFO - PROCESS | 4581 | _x_x_mozilla_cycle_collect,826 16:12:55 INFO - PROCESS | 4581 | __end_cc_report 16:12:55 INFO - PROCESS | 4581 | __startTimestamp1467241975364__endTimestamp 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | ------- Summary: start ------- 16:12:55 INFO - PROCESS | 4581 | Number of tests: 14 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#0] ai-astar Cycles:10 Average:109.10 Median:111.00 stddev:3.73 (3.4%) stddev-sans-first:3.95 16:12:55 INFO - PROCESS | 4581 | Values: 109.0 110.0 104.0 109.0 112.0 111.0 101.0 112.0 112.0 111.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:157.50 stddev:19.89 (12.6%) stddev-sans-first:20.23 16:12:55 INFO - PROCESS | 4581 | Values: 167.0 128.0 160.0 175.0 129.0 155.0 153.0 134.0 180.0 129.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 16:12:55 INFO - PROCESS | 4581 | Values: 161.0 163.0 162.0 164.0 162.0 162.0 163.0 161.0 162.0 164.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#3] audio-fft Cycles:10 Average:96.30 Median:76.00 stddev:42.28 (55.6%) stddev-sans-first:44.20 16:12:55 INFO - PROCESS | 4581 | Values: 76.0 77.0 78.0 177.0 74.0 76.0 76.0 76.0 176.0 77.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:91.50 stddev:27.63 (30.2%) stddev-sans-first:28.57 16:12:55 INFO - PROCESS | 4581 | Values: 91.0 92.0 158.0 91.0 92.0 92.0 147.0 92.0 91.0 139.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 16:12:55 INFO - PROCESS | 4581 | Values: 117.0 117.0 116.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:12:55 INFO - PROCESS | 4581 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 146.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:12:55 INFO - PROCESS | 4581 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 96.0 94.0 95.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:56.50 stddev:6.11 (10.8%) stddev-sans-first:6.36 16:12:55 INFO - PROCESS | 4581 | Values: 55.0 57.0 56.0 55.0 56.0 56.0 58.0 75.0 61.0 55.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 16:12:55 INFO - PROCESS | 4581 | Values: 56.0 56.0 57.0 58.0 58.0 57.0 58.0 57.0 57.0 57.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:75.00 stddev:3.03 (4.0%) stddev-sans-first:2.50 16:12:55 INFO - PROCESS | 4581 | Values: 82.0 75.0 74.0 78.0 82.0 75.0 75.0 75.0 75.0 75.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#11] stanford-crypto-ccm Cycles:10 Average:122.60 Median:124.50 stddev:8.21 (6.6%) stddev-sans-first:8.65 16:12:55 INFO - PROCESS | 4581 | Values: 120.0 127.0 115.0 113.0 116.0 123.0 126.0 117.0 129.0 140.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:164.50 stddev:3.89 (2.4%) stddev-sans-first:2.85 16:12:55 INFO - PROCESS | 4581 | Values: 173.0 162.0 164.0 166.0 165.0 164.0 170.0 162.0 164.0 160.0 16:12:55 INFO - PROCESS | 4581 | 16:12:55 INFO - PROCESS | 4581 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.30 16:12:55 INFO - PROCESS | 4581 | Values: 69.0 66.0 70.0 68.0 68.0 68.0 69.0 66.0 68.0 67.0 16:12:55 INFO - PROCESS | 4581 | -------- Summary: end -------- 16:12:55 INFO - PROCESS | 4581 | 16:12:56 INFO - TEST-INFO | 4581: exit 0 16:12:56 INFO - TEST-OK | kraken | took 61008ms 16:12:56 INFO - SUITE-END | took 1169s 16:12:56 INFO - Completed test suite (00:19:30) 16:12:56 INFO - javascript benchmark 16:12:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3263.4125857345675, 3334.8332583370825, 3346.514755360471, 3382.7293816494685, 3394.473856552234, 5489.34127904652, 5532.761345451099, 5568.248286481324, 5590.972045139773, 5622.156676498527, 5536.280283563131, 5543.556515478762, 5549.056660367737, 5561.221428999943, 5579.302587176603, 4969.155243608595, 4988.226824842146, 4992.750362481879, 5044.066847633199, 5055.090083784918, 4987.975060124712, 5061.139606266944, 5098.0, 5115.2071428928575, 5139.640225184238, 5033.647644664875, 5052.520010598987, 5083.567896728782, 5146.305248791403, 5149.74251287436, 5066.569341605968, 5086.92369614456, 5094.108531007059, 5100.0, 5132.127538318495, 4915.188993816016, 4960.776765045545, 4977.576905962997, 5007.198848184309, 5019.247112933052, 5366.624336296461, 5404.378496472917, 5413.566914646819, 5416.458354164592, 5428.430014848463, 5783.190353350535, 5836.416358364172, 5837.9124313135335, 5841.065429531254, 5857.560682948796, 5902.468777810018, 5935.080062590306, 5951.315598706117, 5958.6424814511265, 5977.8804423911715, 5488.945110548883, 5518.0, 5526.585506087019, 5527.806526771584, 5530.032244357221, 5859.853503662357, 6034.849128771728, 6037.818865434044, 6040.697965101727, 6049.364816694184, 5755.395683453261, 5829.921464529076, 5837.211976383219, 5841.007028805113, 5846.736896839652, 5925.111233315038, 5930.55520835939, 5947.137665038632, 5950.315713692894, 5952.255968003999, 5741.311042674905, 5786.855328616818, 5909.527237820964, 5914.8817023659285, 5917.733701983335, 5896.7936122235515, 5907.025340818716, 5919.200907877382, 5939.970300148471, 5962.314333851663, 4491.977540112279, 4493.618042466427, 4506.729596224237, 4507.481639611421, 4537.818487260539, 3953.486046813953, 4019.0354314964784, 4061.3298805696727, 4073.7759423232005, 4093.713440059167, 5511.145772405283, 5647.068233741386, 5695.03184458643, 5717.685527296038, 5739.885202295931, 5861.941380586225, 5911.586188966817, 5917.556183286185, 5926.585139040312, 5927.881442371215, 5634.098544232903, 5676.914846277309, 5707.571932105108, 5719.142128680731, 5743.569232307594, 4926.605871530269, 4994.2508623706735, 5009.874753131201, 5021.372328458942, 5029.170186919117, 6101.969490152521, 6171.876562468726, 6174.9073763892675, 6180.505559555225, 6203.286622038433, 5910.0, 5943.940560594425, 5984.311804142405, 6018.849528761816, 6041.697915104315, 6194.194754681863, 6221.502279817694, 6230.127782110599, 6236.688165591611, 6243.219597550306, 5618.887622247614, 5867.149263356875, 5869.8239052828485, 5869.911951320819, 5901.822945311647, 5909.734061967136, 5963.9105413417965, 5972.13404056418, 5988.28140623128, 6001.549883758648, 5813.128030795415, 5825.70871456434, 5833.912491312719, 5845.941540584539, 5863.296404431496, 5582.358028826737, 5669.20631111653, 5822.0684690449325, 5826.592138550261, 5832.737526811219, 5675.460831221028, 5707.486326230659, 5712.34308054579, 5714.971425142848, 5725.312962444534, 5720.199172115824, 5768.077107662753, 5770.336411312753, 5784.305883294031, 5813.534917206529, 5538.778448862162, 5694.345150307768, 5740.827775166752, 5746.569007324551, 5760.279965004374], "value": 5465.934162988097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.5687731413238, 673.2257903411077, 677.3835809413434, 726.0198731712189, 744.9459015493078, 31714.524282135786, 32862.17844553888, 39820.40269395958, 40225.7988710056, 40760.0, 43218.56781432185, 43695.56304436955, 43739.56260437395, 43813.0, 43848.3422748659, 8747.868781968276, 8922.241609463203, 8945.373823832335, 8947.239484643813, 8951.686690965818, 8764.342674299422, 8868.911310886873, 8870.201681848632, 8881.600327985256, 8901.554922253894, 8874.112588741138, 9218.86171707425, 9222.262219022463, 9228.6308547658, 9250.491222982733, 9078.092190780935, 9136.771580710469, 9154.542272886329, 9155.267578593697, 9162.221211197057, 8952.8657070144, 9055.320850936207, 9068.183863452256, 9076.319276054322, 9077.183053525148, 43212.0, 43698.34452483215, 43707.34438983418, 43730.562694372966, 43843.12313753739, 3954.3277642800795, 4004.0590461241586, 4026.8993275168064, 4148.771817550033, 4643.141018911479, 31869.84065079683, 32437.0, 32661.0, 33226.833865830515, 33847.32305353904, 4541.067106220588, 4642.094791515656, 4643.489216186217, 4649.628029757611, 4652.930206046912, 317340.0, 317403.9999999977, 318074.0, 318943.0, 319784.0, 60636.0, 61071.38928610746, 61113.69443152756, 61122.694386527786, 61260.693696531234, 69003.30996690069, 69359.30640693528, 69385.30614693789, 69389.0, 69409.3059069413, 17692.29230830778, 17788.644227115645, 17816.821831781777, 17833.732494012602, 17858.464246072377, 15477.845221547866, 15540.922295388451, 15560.22198890051, 15615.297311620778, 15616.297266623029, 20788.0, 20879.373618791462, 21078.156873724878, 21111.155553777982, 21231.36305910825, 7640.121386040565, 7717.961410192913, 7718.92281077182, 7895.539325224851, 8087.797805054803, 1171.3499008050444, 1175.2830773228325, 1220.5544976083843, 1232.383808095952, 1255.4789762248747, 32552.53513591894, 32879.741031018086, 32952.505712414335, 33181.17047073843, 33966.83016584901, 1189.1378750405886, 1234.7160153164823, 1283.5956673647959, 1314.78963365861, 1369.383777300219, 17212.741808872877, 17214.0, 17263.482095537154, 17492.300307987538, 17660.381886633906, 503724.0, 558351.0, 912783.0, 917923.0, 926213.0, 61237.38762612406, 62774.686126569075, 62974.68512657408, 63219.367806321345, 63270.683646582394, 1534.5549790560835, 1537.8846586506056, 1544.4208421841809, 1557.128008315347, 1613.7175994201202, 32714.34571308608, 32940.341193175525, 33445.66554334426, 33752.32495350128, 34222.82888585541, 54035.729821350644, 54804.45195547993, 54876.0, 54895.72552137214, 55015.44984550103, 441060.0, 445568.0, 445806.0, 446242.0, 446421.0, 30792.0, 30809.229769255948, 31245.687543125186, 31262.37475250528, 31419.214519636276, 49020.509794903024, 49233.507664922894, 49444.50555494543, 49477.25784113169, 50172.498275016784, 39297.0, 41257.58742412538, 41694.0, 42286.0, 42702.0, 40849.59150408458, 41164.176716464906, 41294.1741165169, 41410.37884431676, 41533.169336613704, 42194.156116876875, 44368.778156109016, 44613.776931115135, 44830.0, 45764.31353529633, 35046.0, 35264.647353527165, 35609.64390356063, 36180.27639447249, 36261.27477450489, 28882.855585722777, 29093.272668183465, 29113.563296550146, 29522.704772951995, 29534.852325738233], "value": 21373.07689539906, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.29893778452185, 421.69005780751144, 424.7960978730209, 425.11151692961704, 428.26338697440394, 18579.163937622805, 19318.227270909163, 19370.128344224508, 19677.70483442746, 20729.274475393366, 19520.90239548804, 19723.1124599393, 20121.396358109243, 20391.796082039175, 20541.4864628384, 5540.335159780832, 5555.444455554442, 5808.506276966442, 5809.477147056764, 5828.125781132842, 5706.77172913083, 5719.656820590778, 5752.539796816265, 5761.423857614226, 5794.768209271624, 5563.777448902059, 5677.48902598766, 5725.370209276997, 5738.713064346766, 5763.9711801440935, 5614.382417934024, 5618.662880227179, 5629.380768115504, 5641.26663533738, 5658.74535645897, 5080.187170052774, 5110.233464980245, 5123.359580052494, 5483.232347471358, 5739.885202295973, 14410.351534180987, 14679.706405871822, 14692.191929443876, 15567.688646227012, 23206.65190022151, 2474.8020158387285, 2475.8724195167692, 2533.442642618621, 2576.9098081567054, 2617.3718307606227, 10146.644867429604, 10313.226508011854, 10421.27051106423, 10436.37381757097, 10457.0, 1958.2069261948934, 2026.0882602828785, 2104.5054412213117, 2121.7666056733747, 2147.9892600537055, 81374.59312703398, 83694.74457883197, 85144.0, 86042.0, 86567.56716216441, 11123.0, 11473.368964706855, 11513.30920144794, 12089.03287736979, 12356.073294502768, 15918.602034948988, 16010.439634612732, 16131.112788796494, 16224.432144875109, 16274.104924229045, 8665.13348665141, 8926.419782714103, 9154.947181074129, 9242.630294788267, 9246.76883077915, 8986.236169925629, 9026.86459703105, 9054.81890362189, 9059.637614495346, 9249.260059195249, 4947.0, 4955.0, 4975.577075948512, 4986.975065124724, 5037.0681423936685, 2008.8292495138078, 2035.6641154209685, 2064.576761763865, 2073.7822528634274, 2122.5754849029945, 1047.586203449633, 1077.7952189084049, 1095.8301463273046, 1118.1502058435647, 1143.9656810295537, 18359.265629374942, 18587.44237672872, 18817.15322810477, 19107.522311942314, 19324.1304141314, 1050.9001644843727, 1079.2351766948832, 1124.7019539821954, 1132.8867113288604, 1194.707296712311, 10653.680389588324, 10704.1436685065, 10807.945960270148, 10839.783204335869, 10901.618443354444, 566230.0, 579552.0, 616417.0, 635996.0, 642165.0, 73869.0, 86560.0, 87049.56475217584, 102247.0, 103765.0, 1168.6026750904732, 1171.7832201042834, 1176.4411904345368, 1207.3540655749132, 1231.5751065882257, 17241.431005791404, 17555.297788088843, 17723.025233612276, 17805.46583602494, 18003.2798688051, 41593.1681366377, 41994.74015779531, 42043.789781052124, 42518.78740606277, 42597.78701106475, 61204.69397652983, 61913.0, 62781.37218627755, 62976.68511657596, 63142.368576313645, 8743.169398907094, 8897.866532002156, 8972.955135224282, 9015.909840901508, 9218.308626853148, 12445.0, 13078.346082696018, 13348.866511334762, 13512.459501620218, 14004.719905602034, 11773.764524709286, 12037.217580857216, 12176.634700958986, 12354.814677780021, 12557.93721031389, 12214.450349734105, 12244.142909996215, 12390.132690711924, 12419.689507762378, 12743.426545805647, 12319.384030798603, 12963.740725185633, 13181.736365272833, 13220.206787592775, 13334.133281336683, 9225.308101892251, 9346.813063738824, 9430.387024843363, 9438.150566449052, 9541.236701064037, 12219.69450763738, 12457.626271211879, 12694.492220311453, 12873.0, 12886.67783305425], "value": 9608.020243253828, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1571.7878086458327, 1594.481793417139, 1780.9554761130971, 1877.1740434208955, 1902.134528789401, 7497.625118744055, 8016.799580010488, 8282.62728177232, 8455.154484551542, 8487.854139691131, 7865.724699635514, 8081.313088387479, 8091.2717855393, 8322.33421326294, 8411.789705257372, 2483.739207383221, 2502.612095125249, 2504.9749502505015, 2525.4570267392505, 2526.608375701769, 2486.477839653675, 2542.2881593153948, 2552.1960582416573, 2553.195743340851, 2553.3871870750977, 2489.514544663791, 2499.462615537659, 2500.812439067068, 2503.7120731115883, 2515.5220508103403, 2498.750124987496, 2500.8749562521803, 2514.120057979711, 2514.8994040238554, 2520.117958714454, 2504.0, 2523.6088406297054, 2532.3162746058647, 2535.7083935347487, 2550.0309882244815, 8634.136586341378, 8673.262772664331, 8694.043655197924, 8695.130486951255, 8708.695195668184, 5402.486763757437, 5524.14375771752, 5570.359408668014, 5571.804986825482, 5576.0241957657245, 3560.12776869666, 3581.247937933037, 3604.873829415984, 3715.4055351143957, 3729.1236559408517, 1185.875483074282, 1189.9464524096436, 1218.7745267125522, 1223.2354778263584, 1247.7566874459485, 11770.41147942608, 11811.704707382298, 11832.526698932032, 11857.525698972031, 11872.465739041678, 4598.195315819718, 4630.791614377361, 4661.557152070548, 4685.250359942393, 4690.89763905482, 9415.90584094164, 9418.529073546295, 9420.057994200524, 9457.29070319715, 9462.43225406464, 5376.1398176291605, 5395.487428694268, 5400.108982017923, 5401.378841433207, 5423.322084739408, 4967.254911763264, 5051.545360917535, 5071.2139618359215, 5092.032513822362, 5093.668911520739, 3949.7037722170376, 3972.841086356513, 4048.39274108886, 4097.487814023247, 4133.152703695795, 1207.3419986107417, 1208.4501551793912, 1216.7505661339403, 1219.5182902753363, 1235.610782603477, 1081.3349789879326, 1087.374759513283, 1095.2661716649864, 1098.6429410441638, 1120.9439528023565, 5894.970525147432, 5954.10688396744, 5975.910361344583, 6033.728482218311, 6055.545834062463, 469.567997442347, 470.6752340884847, 471.59442879123924, 1122.7586068995206, 1136.9653615210118, 4129.8967525812095, 4156.127213285244, 4176.14389050244, 4197.538270790211, 4309.698321117492, 9954.153896918842, 10121.69634910954, 10216.233782466345, 10240.283180177315, 10290.176785857113, 10039.648612298535, 10073.49632518371, 10079.143272821892, 10135.442550659636, 10139.391636501834, 7725.536467811837, 8011.319037881729, 8128.634211460499, 8141.552214628134, 8146.918530814734, 5899.351071382231, 5961.791337303347, 5971.223740913653, 5988.28140623128, 6087.786927457518, 8872.955635221782, 8924.776880578038, 8926.509042002752, 8992.190702836777, 9001.459912405277, 9034.909650903406, 9476.763080922756, 9568.904310956801, 9639.132478077006, 9712.70861874145, 6600.07598936159, 7150.356467917913, 7328.523645963209, 7372.631368431665, 7432.3310902019075, 7978.481398709066, 8006.91993080085, 8022.679092836222, 8033.076196237507, 8045.477043992122, 7197.676104575411, 7320.121585409572, 7406.629668516445, 7453.850922981618, 7496.437767167376, 7177.569345839266, 7218.169910460154, 7227.27727227273, 7254.202037775735, 7310.378617817332, 6904.206016308189, 6909.0, 6913.51605387618, 6955.061066755923, 6983.266756990442, 5082.652857996356, 5198.435992080391, 5247.507433968834, 5347.0, 5369.033573956569, 5278.97360513195, 5295.099833028471, 5334.3865455473115, 5422.8373148805595, 5424.620276580601], "value": 4624.754077752774, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.10739647331053, 350.34135824649655, 351.28162906855476, 358.8421094718324, 360.23629904602245, 6559.967200163998, 6573.638449885254, 6672.366125218108, 6688.331166883316, 6709.127813384265, 6533.575317604353, 6564.212294524652, 6568.934310656892, 6577.046328282396, 6585.0, 4745.050989802045, 4899.167141585939, 4923.70457772533, 4927.901441971158, 4935.0376676548085, 4906.5093490650825, 4912.091263116317, 4917.065757506062, 4925.162722337212, 4932.186189278765, 4866.391701037371, 4887.1447496688115, 4890.462049174588, 4896.216605343146, 4897.730624815652, 4890.119778439879, 4900.0, 4900.509949005089, 4902.313676085351, 4910.288008238821, 4236.978815105905, 4237.7669228192435, 4239.0674051708575, 4241.957580424187, 4249.128928569667, 6179.81460556184, 6280.811575652738, 6316.210473690789, 6326.177596912418, 6336.398042185985, 5669.092945128801, 5718.313802343745, 5720.11338242573, 5724.341700704431, 5724.513416359614, 6899.241083480813, 6903.792886213421, 6909.136357955255, 6920.342567456134, 6923.065386172903, 4693.507181745902, 4699.295105734167, 4702.177119004161, 4705.882352941169, 4717.858464246078, 7184.497085204038, 7189.245129261457, 7205.423566114699, 7250.3112204340505, 7257.983882256488, 4667.32323813052, 4746.311784791186, 4770.260609605517, 4786.521347865186, 4787.4494433139935, 4827.662063655511, 4851.684640498356, 4855.490173531799, 4862.07620552094, 4864.124457597666, 5670.688112153789, 5671.319441666944, 5678.290213723285, 5680.375158732536, 5689.459501347365, 6929.653517324215, 6963.8607227855155, 6987.1266091738535, 6999.51003429755, 6999.510034297652, 1688.856447201977, 1714.9657006859793, 1716.21054315014, 1716.3392094043634, 1725.387487441965, 1049.338916482611, 1103.0568863621488, 1117.3072694929033, 1123.2474242257706, 1124.100719424457, 6796.626185559743, 6814.454843612499, 6815.795526134125, 6823.829404264933, 6824.863502730017, 7180.640967951582, 7199.06412166415, 7199.280071992864, 7223.674934627954, 7248.0939882514685, 6669.333066693292, 6786.660666966731, 6879.449644028466, 6883.586984780929, 6890.724371025203, 3892.824822882977, 3897.0452239201577, 3897.415387691869, 3930.862419815293, 3942.9014274643364, 7608.391328693691, 7608.923910760932, 7617.619119044026, 7620.695172193161, 7628.656710448043, 7282.70869165238, 7375.926240737524, 7417.740379086706, 7417.888731669029, 7428.85142297151, 7589.089309282811, 7598.20218877021, 7608.277213664804, 7612.7716168515035, 7623.856421536814, 7203.963980180066, 7225.205227424874, 7243.058402407653, 7252.818679533054, 7258.49190556656, 7118.466115041496, 7126.0, 7131.286871312827, 7134.750283740044, 7148.785536433916, 7432.516886402366, 7552.773416797505, 7586.165521792488, 7603.239676032574, 7629.847403052019, 4776.307435421775, 4811.927821082757, 4820.1805693031565, 4838.8790280241865, 4845.442774080885, 7206.459515536251, 7254.96372518134, 7256.637168141678, 7279.818004549928, 7280.781576552712, 7003.159620845531, 7011.789646310619, 7015.859682806417, 7027.648617569203, 7038.331358520933, 6862.245153033262, 7003.0, 7011.789646310619, 7032.472564557781, 7051.823704407431, 6870.793876183722, 6890.31096890307, 6890.655467226718, 6894.655267236719, 6908.758193463204, 7036.859262814817, 7054.153501579844, 7068.222495525385, 7069.681864316015, 7077.327653872874, 6880.105586273752, 6888.483363747639, 6894.8621027580175, 6895.75864844728, 6902.792916212522], "value": 5220.474397783221, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [922.4557511068471, 930.6137952749609, 933.5052422216223, 937.8265020971119, 953.828310904037, 14784.408623655054, 14902.627434314147, 14951.327190276437, 14958.626034349147, 15077.0, 14245.786313205284, 14550.345234464448, 14557.0, 14561.0, 14698.559043228694, 748.0275641665839, 901.1529162587179, 908.2280061947358, 909.9444644212715, 934.6354921580589, 924.7780532672177, 928.2759447630825, 928.8095940332249, 928.9117533834309, 930.1210356213347, 966.2656381150341, 967.5549247346229, 971.7376308396729, 972.4019727867346, 976.0, 961.0821665309647, 961.3366776923936, 961.4471678784657, 962.6390103711109, 963.0802583532709, 707.762899428692, 708.9858202835966, 710.8400609862791, 711.7829062136046, 712.7256006437507, 14258.358373873201, 14271.00102992791, 14360.856391436057, 14365.281735913162, 14365.856341436556, 14298.142111473346, 14384.424623015171, 14406.351714172888, 14526.34631441577, 14794.926025369912, 11997.94001029998, 12112.636620901387, 12232.571859984857, 12274.0, 12297.69255768604, 4061.634452899253, 4064.3497040473676, 4074.7351422157762, 4097.795110244506, 4106.527749308838, 54549.0, 55423.72288138574, 55766.44233557653, 55876.0, 56012.15981760277, 11806.88193118075, 12050.156489045683, 12052.638420847388, 12178.878211217952, 12189.451474683661, 21880.78119218819, 21902.890485547472, 21904.0, 21906.0, 21921.671174932388, 8586.742397728078, 8609.698660546976, 8676.219140277406, 8746.912530874737, 8773.0, 4889.437714662859, 4954.9752251238515, 4955.4548999610015, 4956.801727930914, 4979.975100124476, 3462.5498685170764, 3484.5992710838073, 3488.581370235537, 3515.5781306243416, 3525.7355698322726, 578.7222133376004, 628.3465196195997, 640.1645852162972, 644.7453255963868, 645.1097485470021, 765.689895592286, 826.7065191856924, 840.206005324962, 840.369722707969, 867.2584939876441, 9242.907570924339, 9396.859047114298, 9467.952660236793, 9485.098915603006, 9581.089796469325, 728.559221670892, 801.555136899015, 817.1093508076107, 833.9749807505784, 834.5660256666499, 4357.411749413852, 4494.325851122292, 4545.909081818411, 4631.3516107744945, 4751.976240118777, 60963.695181524694, 61020.69489652523, 61431.69284153551, 61573.0, 67581.66209168923, 54210.45789542133, 54379.45620543744, 54868.45131548633, 54984.725076374365, 55486.0, 49265.014699705804, 49554.1337598719, 49903.50096499061, 49913.75043124761, 49921.251181231586, 9987.750306242402, 10118.19054475655, 10187.235957303084, 10248.795024099625, 10345.0, 36910.0, 37062.814685926394, 37917.0, 38459.61540384672, 38541.2291754169, 45526.317105242786, 45715.77142114268, 47515.0, 47808.76095619639, 47813.28280075732, 12050.156489045683, 12703.42834572465, 12805.551805686757, 12877.034222433542, 13009.869901300866, 13779.242141682304, 14035.438582456996, 14103.435862565382, 14152.292385380484, 14221.715565688835, 12504.312262825631, 12631.431585578855, 12727.809082863949, 12963.546275880299, 13471.595852124452, 13048.804267935799, 13139.868601314247, 13174.275414852274, 13401.262930538915, 13462.528811491551, 12355.75288494243, 12714.300713460849, 13044.152130111512, 13122.409491572711, 13349.466021359036, 10644.89355106439, 10813.513391897226, 10945.83581246266, 11039.668809935714, 11058.889411106107, 11340.489677964677, 11359.261647992855, 11565.942170289094, 11572.710682233012, 11701.590444334408], "value": 7186.163922618036, "unit": "score"}], "name": "dromaeo_css", "value": 7613.486023226534, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 104.0, 109.0, 112.0, 111.0, 101.0, 112.0, 112.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 128.0, 160.0, 175.0, 129.0, 155.0, 153.0, 134.0, 180.0, 129.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 164.0, 162.0, 162.0, 163.0, 161.0, 162.0, 164.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 177.0, 74.0, 76.0, 76.0, 76.0, 176.0, 77.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 158.0, 91.0, 92.0, 92.0, 147.0, 92.0, 91.0, 139.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 55.0, 56.0, 56.0, 58.0, 75.0, 61.0, 55.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 58.0, 58.0, 57.0, 58.0, 57.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 74.0, 78.0, 82.0, 75.0, 75.0, 75.0, 75.0, 75.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 127.0, 115.0, 113.0, 116.0, 123.0, 126.0, 117.0, 129.0, 140.0], "value": 122.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 162.0, 164.0, 166.0, 165.0, 164.0, 170.0, 162.0, 164.0, 160.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 70.0, 68.0, 68.0, 68.0, 69.0, 66.0, 68.0, 67.0], "value": 67.9, "unit": "score"}], "name": "kraken", "value": 1533.4999999999998, "alertThreshold": 2.0}]} 16:12:56 INFO - Return code: 0 16:12:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:12:56 ERROR - # TBPL SUCCESS # 16:12:56 INFO - Running post-action listener: _resource_record_post_action 16:12:56 INFO - Running post-run listener: _resource_record_post_run 16:12:57 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462827520; Read time: 8; Write time: 477000 16:12:57 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 248934400; Read time: 0; Write time: 316608 16:12:57 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 213893120; Read time: 8; Write time: 160392 16:12:57 INFO - Running post-run listener: _upload_blobber_files 16:12:57 INFO - Blob upload gear active. 16:12:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:12:57 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 16:12:57 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'] 16:12:57 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 16:12:58 INFO - (blobuploader) - INFO - Open directory for files ... 16:12:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:12:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:58 INFO - (blobuploader) - INFO - Done attempting. 16:12:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:12:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:12:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:12:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:12:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:12:59 INFO - (blobuploader) - INFO - Done attempting. 16:12:59 INFO - (blobuploader) - INFO - Iteration through files over. 16:12:59 INFO - Return code: 0 16:12:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:12:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:12:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ece78be72a99719cd8f382563468d9a769d948f9d7ec3c5a4e5f13d1d596aaff59638b4fae58a14877accc0ca7f42c91ad83a27dc6744a8110bbbb7c135a2877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f447683bc38297251194a802681f38ac264126d7ae84c99ed4752450833936df05caf11c1738919e6fa128cc1e530d3e4f9eb6aaa53aa7ba6cf0bd874c46b364"} 16:12:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:12:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:12:59 INFO - Contents: 16:12:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ece78be72a99719cd8f382563468d9a769d948f9d7ec3c5a4e5f13d1d596aaff59638b4fae58a14877accc0ca7f42c91ad83a27dc6744a8110bbbb7c135a2877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f447683bc38297251194a802681f38ac264126d7ae84c99ed4752450833936df05caf11c1738919e6fa128cc1e530d3e4f9eb6aaa53aa7ba6cf0bd874c46b364"} 16:12:59 INFO - Running post-run listener: copy_logs_to_upload_dir 16:12:59 INFO - Copying logs to upload dir... 16:12:59 INFO - mkdir: /builds/slave/test/build/upload/logs 16:12:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.393431 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-06-29 16:12:58.244681) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 16:12:58.248023) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733 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/ece78be72a99719cd8f382563468d9a769d948f9d7ec3c5a4e5f13d1d596aaff59638b4fae58a14877accc0ca7f42c91ad83a27dc6744a8110bbbb7c135a2877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f447683bc38297251194a802681f38ac264126d7ae84c99ed4752450833936df05caf11c1738919e6fa128cc1e530d3e4f9eb6aaa53aa7ba6cf0bd874c46b364"} build_url:https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011190 build_url: 'https://queue.taskcluster.net/v1/task/IX-YgXr9SiyDKQv1fnGdUQ/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/ece78be72a99719cd8f382563468d9a769d948f9d7ec3c5a4e5f13d1d596aaff59638b4fae58a14877accc0ca7f42c91ad83a27dc6744a8110bbbb7c135a2877", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f447683bc38297251194a802681f38ac264126d7ae84c99ed4752450833936df05caf11c1738919e6fa128cc1e530d3e4f9eb6aaa53aa7ba6cf0bd874c46b364"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 16:12:58.274026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:12:58.274363) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467239998.820744-417234733 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 16:12:58.357581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 16:12:58.357908) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 16:12:58.358259) ========= ========= Total master_lag: 0.16 =========