builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1461543272.75 results: success (0) buildid: 20160424143014 builduid: 1dccabe045c04a67a8895df8fb62a2ca revision: 7e35addd4309d83144512aa27eccb15d72ec1291 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:32.752788) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:32.759498) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:32.759838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:32.801521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:32.801814) ========= 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=32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-24 17:14:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.0M=0s 2016-04-24 17:14:33 (59.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120878 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:32.944644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:32.945069) ========= 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=32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020614 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:33.006491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:33.006828) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7e35addd4309d83144512aa27eccb15d72ec1291 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7e35addd4309d83144512aa27eccb15d72ec1291 --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=32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-24 17:14:33,144 truncating revision to first 12 chars 2016-04-24 17:14:33,144 Setting DEBUG logging. 2016-04-24 17:14:33,144 attempt 1/10 2016-04-24 17:14:33,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7e35addd4309?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 17:14:33,760 unpacking tar archive at: fx-team-7e35addd4309/testing/mozharness/ program finished with exit code 0 elapsedTime=0.903689 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:33.930133) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:33.930487) ========= script_repo_revision: 7e35addd4309d83144512aa27eccb15d72ec1291 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:33.930911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:33.931249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 17:14:33.942300) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-24 17:14:33.942656) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:14:34 INFO - MultiFileLogger online at 20160424 17:14:34 in /builds/slave/test 17:14:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:14:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:14:34 INFO - {'append_to_log': False, 17:14:34 INFO - 'base_work_dir': '/builds/slave/test', 17:14:34 INFO - 'blob_upload_branch': 'Fx-Team', 17:14:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:14:34 INFO - 'branch': 'Fx-Team', 17:14:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:14:34 INFO - 'config_files': ('talos/linux_config.py',), 17:14:34 INFO - 'default_actions': ('clobber', 17:14:34 INFO - 'read-buildbot-config', 17:14:34 INFO - 'download-and-extract', 17:14:34 INFO - 'populate-webroot', 17:14:34 INFO - 'create-virtualenv', 17:14:34 INFO - 'install', 17:14:34 INFO - 'run-tests'), 17:14:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:14:34 INFO - 'download_minidump_stackwalk': True, 17:14:34 INFO - 'download_symbols': 'ondemand', 17:14:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:14:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:14:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:14:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:14:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:14:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:14:34 INFO - 'installer_path': 'installer.exe', 17:14:34 INFO - 'log_level': 'info', 17:14:34 INFO - 'log_name': 'talos', 17:14:34 INFO - 'log_to_console': True, 17:14:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:14:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:14:34 INFO - 'opt_config_files': (), 17:14:34 INFO - 'pip_index': False, 17:14:34 INFO - 'sps_profile': False, 17:14:34 INFO - 'sps_profile_interval': 0, 17:14:34 INFO - 'suite': 'dromaeojs-e10s', 17:14:34 INFO - 'system_bits': '32', 17:14:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:14:34 INFO - 'title': 'talos-linux64-ix-008', 17:14:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:14:34 INFO - 'use_talos_json': True, 17:14:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:14:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:14:34 INFO - 'work_dir': 'build'} 17:14:34 INFO - ##### 17:14:34 INFO - ##### Running clobber step. 17:14:34 INFO - ##### 17:14:34 INFO - Running pre-action listener: _resource_record_pre_action 17:14:34 INFO - Running main action method: clobber 17:14:34 INFO - rmtree: /builds/slave/test/build 17:14:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:14:34 INFO - Running post-action listener: _resource_record_post_action 17:14:34 INFO - ##### 17:14:34 INFO - ##### Running read-buildbot-config step. 17:14:34 INFO - ##### 17:14:34 INFO - Running pre-action listener: _resource_record_pre_action 17:14:34 INFO - Running main action method: read_buildbot_config 17:14:34 INFO - Using buildbot properties: 17:14:34 INFO - { 17:14:34 INFO - "project": "", 17:14:34 INFO - "product": "firefox", 17:14:34 INFO - "script_repo_revision": "production", 17:14:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:14:34 INFO - "repository": "", 17:14:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:14:34 INFO - "buildid": "20160424143014", 17:14:34 INFO - "pgo_build": "True", 17:14:34 INFO - "basedir": "/builds/slave/test", 17:14:34 INFO - "buildnumber": 409, 17:14:34 INFO - "slavename": "talos-linux64-ix-008", 17:14:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:14:34 INFO - "platform": "ubuntu64_hw", 17:14:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:14:34 INFO - "branch": "fx-team", 17:14:34 INFO - "repo_path": "integration/fx-team", 17:14:34 INFO - "revision": "7e35addd4309d83144512aa27eccb15d72ec1291", 17:14:34 INFO - "stage_platform": "linux64-pgo", 17:14:34 INFO - "builduid": "1dccabe045c04a67a8895df8fb62a2ca", 17:14:34 INFO - "slavebuilddir": "test" 17:14:34 INFO - } 17:14:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 17:14:34 INFO - Running post-action listener: _resource_record_post_action 17:14:34 INFO - ##### 17:14:34 INFO - ##### Running download-and-extract step. 17:14:34 INFO - ##### 17:14:34 INFO - Running pre-action listener: _resource_record_pre_action 17:14:34 INFO - Running main action method: download_and_extract 17:14:34 INFO - mkdir: /builds/slave/test/build/tests 17:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:34 INFO - https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:14:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:14:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:14:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:14:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:14:48 INFO - Downloaded 1361 bytes. 17:14:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 17:14:48 INFO - Using the following test package requirements: 17:14:48 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:14:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:14:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:14:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'jsshell-linux-x86_64.zip'], 17:14:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:14:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 17:14:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:14:48 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:14:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:14:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 17:14:48 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:14:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:14:48 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')]} 17:14:48 INFO - https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:14:51 INFO - Downloaded 23857341 bytes. 17:14:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:14:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:14:52 INFO - Return code: 0 17:14:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:14: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')]} 17:14:52 INFO - https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:14:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 17:14:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:14:54 INFO - Downloaded 23857341 bytes. 17:14:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:14:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 17:14:55 INFO - Return code: 0 17:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:55 INFO - https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:14:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:14:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:14:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 17:14:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:14:56 INFO - Downloaded 10840145 bytes. 17:14:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:14:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 17:14:56 INFO - Return code: 0 17:14:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:57 INFO - https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:14:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:14:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:14:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:14:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:14:58 INFO - Downloaded 58334471 bytes. 17:14:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:14:58 INFO - mkdir: /builds/slave/test/properties 17:14:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:14:58 INFO - Writing to file /builds/slave/test/properties/build_url 17:14:58 INFO - Contents: 17:14:58 INFO - build_url:https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 17:14:59 INFO - Running post-action listener: _resource_record_post_action 17:14:59 INFO - Running post-action listener: set_extra_try_arguments 17:14:59 INFO - ##### 17:14:59 INFO - ##### Running populate-webroot step. 17:14:59 INFO - ##### 17:14:59 INFO - Running pre-action listener: _resource_record_pre_action 17:14:59 INFO - Running main action method: populate_webroot 17:14:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:14:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:14:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:14:59 INFO - '--tppagecycles', 17:14:59 INFO - '7'], 17:14:59 INFO - 'tests': ['tsvgm']}}, 17:14:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:14:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:14:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:14:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:14:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:59 INFO - 'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:14:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:59 INFO - 'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['damp', 'tps']}, 17:14:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:59 INFO - 'tests': ['damp', 'tps']}, 17:14:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['dromaeo_dom']}, 17:14:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:14:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['a11yr', 17:14:59 INFO - 'ts_paint', 17:14:59 INFO - 'tpaint', 17:14:59 INFO - 'sessionrestore', 17:14:59 INFO - 'sessionrestore_no_auto_restore', 17:14:59 INFO - 'tabpaint']}, 17:14:59 INFO - 'other-e10s': {'tests': ['a11yr', 17:14:59 INFO - 'ts_paint', 17:14:59 INFO - 'tpaint', 17:14:59 INFO - 'sessionrestore', 17:14:59 INFO - 'sessionrestore_no_auto_restore', 17:14:59 INFO - 'tabpaint']}, 17:14:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:14:59 INFO - 'ts_paint', 17:14:59 INFO - 'tpaint', 17:14:59 INFO - 'sessionrestore', 17:14:59 INFO - 'sessionrestore_no_auto_restore', 17:14:59 INFO - 'tabpaint']}, 17:14:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:14:59 INFO - 'ts_paint', 17:14:59 INFO - 'tpaint', 17:14:59 INFO - 'sessionrestore', 17:14:59 INFO - 'sessionrestore_no_auto_restore', 17:14:59 INFO - 'tabpaint']}, 17:14:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['a11yr', 17:14:59 INFO - 'ts_paint', 17:14:59 INFO - 'tpaint', 17:14:59 INFO - 'sessionrestore', 17:14:59 INFO - 'sessionrestore_no_auto_restore', 17:14:59 INFO - 'tabpaint']}, 17:14:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['a11yr', 17:14:59 INFO - 'ts_paint', 17:14:59 INFO - 'tpaint', 17:14:59 INFO - 'sessionrestore', 17:14:59 INFO - 'sessionrestore_no_auto_restore', 17:14:59 INFO - 'tabpaint']}, 17:14:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['tsvgx', 17:14:59 INFO - 'tsvgr_opacity', 17:14:59 INFO - 'tart', 17:14:59 INFO - 'tscrollx', 17:14:59 INFO - 'cart']}, 17:14:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:14:59 INFO - 'tsvgr_opacity', 17:14:59 INFO - 'tart', 17:14:59 INFO - 'tscrollx', 17:14:59 INFO - 'cart']}, 17:14:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:59 INFO - 'talos_options': ['--disable-e10s'], 17:14:59 INFO - 'tests': ['tp5o']}, 17:14:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:59 INFO - 'tests': ['tp5o']}, 17:14:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:59 INFO - 'talos_options': ['--disable-e10s', 17:14:59 INFO - '--xperf_path', 17:14:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:59 INFO - 'tests': ['tp5n']}, 17:14:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:14:59 INFO - 'talos_options': ['--xperf_path', 17:14:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:14:59 INFO - 'tests': ['tp5n']}}, 17:14:59 INFO - 'talos.zip': {'path': '', 17:14:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:14:59 INFO - Running post-action listener: _resource_record_post_action 17:14:59 INFO - ##### 17:14:59 INFO - ##### Running create-virtualenv step. 17:14:59 INFO - ##### 17:14:59 INFO - Running pre-action listener: _resource_record_pre_action 17:14:59 INFO - Running main action method: create_virtualenv 17:14:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:14:59 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 17:14:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:14:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:14:59 INFO - Using real prefix '/usr' 17:14:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:14:59 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:01 INFO - Installing pip.................done. 17:15:01 INFO - Return code: 0 17:15:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:01 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 0x7f6508a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, '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': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', '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 17:15:01 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 17:15:01 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 17:15:01 INFO - Using env: {'DISPLAY': ':0', 17:15:01 INFO - 'HOME': '/home/cltbld', 17:15:01 INFO - 'LANG': 'en_US.UTF-8', 17:15:01 INFO - 'LANGUAGE': 'en_US:en', 17:15:01 INFO - 'LOGNAME': 'cltbld', 17:15:01 INFO - 'MAIL': '/var/mail/cltbld', 17:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:01 INFO - 'MOZ_NO_REMOTE': '1', 17:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:01 INFO - 'NO_EM_RESTART': '1', 17:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:01 INFO - 'PWD': '/builds/slave/test', 17:15:01 INFO - 'SHELL': '/bin/bash', 17:15:01 INFO - 'SHLVL': '1', 17:15:01 INFO - 'TERM': 'linux', 17:15:01 INFO - 'TMOUT': '86400', 17:15:01 INFO - 'USER': 'cltbld', 17:15:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:01 INFO - '_': '/tools/buildbot/bin/python'} 17:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:02 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 17:15:02 INFO - Cleaning up... 17:15:02 INFO - Return code: 0 17:15:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:15:02 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')]} 17:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:02 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')]} 17:15:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:02 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 0x7f6508a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, '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': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', '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 17:15:02 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 17:15:02 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 17:15:02 INFO - Using env: {'DISPLAY': ':0', 17:15:02 INFO - 'HOME': '/home/cltbld', 17:15:02 INFO - 'LANG': 'en_US.UTF-8', 17:15:02 INFO - 'LANGUAGE': 'en_US:en', 17:15:02 INFO - 'LOGNAME': 'cltbld', 17:15:02 INFO - 'MAIL': '/var/mail/cltbld', 17:15:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:02 INFO - 'MOZ_NO_REMOTE': '1', 17:15:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:02 INFO - 'NO_EM_RESTART': '1', 17:15:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:02 INFO - 'PWD': '/builds/slave/test', 17:15:02 INFO - 'SHELL': '/bin/bash', 17:15:02 INFO - 'SHLVL': '1', 17:15:02 INFO - 'TERM': 'linux', 17:15:02 INFO - 'TMOUT': '86400', 17:15:02 INFO - 'USER': 'cltbld', 17:15:02 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:02 INFO - '_': '/tools/buildbot/bin/python'} 17:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:02 INFO - Downloading/unpacking psutil>=0.7.1 17:15:02 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 17:15:02 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 17:15:02 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 17:15:02 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 17:15:02 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 17:15:02 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 17:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:04 INFO - Installing collected packages: psutil 17:15:04 INFO - Running setup.py install for psutil 17:15:04 INFO - building 'psutil._psutil_linux' extension 17:15:04 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 17:15:04 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 17:15:04 INFO - building 'psutil._psutil_posix' extension 17:15:04 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 17:15:04 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 17:15:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:04 INFO - Successfully installed psutil 17:15:04 INFO - Cleaning up... 17:15:04 INFO - Return code: 0 17:15:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:15: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')]} 17:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15: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')]} 17:15:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:04 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 0x7f6508a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, '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': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', '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 17:15:04 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 17:15:04 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 17:15:04 INFO - Using env: {'DISPLAY': ':0', 17:15:04 INFO - 'HOME': '/home/cltbld', 17:15:04 INFO - 'LANG': 'en_US.UTF-8', 17:15:04 INFO - 'LANGUAGE': 'en_US:en', 17:15:04 INFO - 'LOGNAME': 'cltbld', 17:15:04 INFO - 'MAIL': '/var/mail/cltbld', 17:15:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:04 INFO - 'MOZ_NO_REMOTE': '1', 17:15:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:04 INFO - 'NO_EM_RESTART': '1', 17:15:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:04 INFO - 'PWD': '/builds/slave/test', 17:15:04 INFO - 'SHELL': '/bin/bash', 17:15:04 INFO - 'SHLVL': '1', 17:15:04 INFO - 'TERM': 'linux', 17:15:04 INFO - 'TMOUT': '86400', 17:15:04 INFO - 'USER': 'cltbld', 17:15:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:04 INFO - '_': '/tools/buildbot/bin/python'} 17:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:15:07 INFO - Installing collected packages: mozsystemmonitor 17:15:07 INFO - Running setup.py install for mozsystemmonitor 17:15:07 INFO - Successfully installed mozsystemmonitor 17:15:07 INFO - Cleaning up... 17:15:07 INFO - Return code: 0 17:15:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:07 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 0x7f6508a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, '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': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', '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 17:15:07 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 17:15:07 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 17:15:07 INFO - Using env: {'DISPLAY': ':0', 17:15:07 INFO - 'HOME': '/home/cltbld', 17:15:07 INFO - 'LANG': 'en_US.UTF-8', 17:15:07 INFO - 'LANGUAGE': 'en_US:en', 17:15:07 INFO - 'LOGNAME': 'cltbld', 17:15:07 INFO - 'MAIL': '/var/mail/cltbld', 17:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:07 INFO - 'MOZ_NO_REMOTE': '1', 17:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:07 INFO - 'NO_EM_RESTART': '1', 17:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:07 INFO - 'PWD': '/builds/slave/test', 17:15:07 INFO - 'SHELL': '/bin/bash', 17:15:07 INFO - 'SHLVL': '1', 17:15:07 INFO - 'TERM': 'linux', 17:15:07 INFO - 'TMOUT': '86400', 17:15:07 INFO - 'USER': 'cltbld', 17:15:07 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:07 INFO - '_': '/tools/buildbot/bin/python'} 17:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:07 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 17:15:07 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 17:15:07 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 17:15:07 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 17:15:07 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 17:15:07 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 17:15:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15:09 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 17:15:09 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 17:15:09 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 17:15:09 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 17:15:09 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 17:15:09 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 17:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15: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 17:15:10 INFO - Downloading docopt-0.6.1.tar.gz 17:15:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:10 INFO - Running setup.py install for blobuploader 17:15:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:11 INFO - Running setup.py install for requests 17:15:11 INFO - Running setup.py install for docopt 17:15:11 INFO - Successfully installed blobuploader requests docopt 17:15:11 INFO - Cleaning up... 17:15:11 INFO - Return code: 0 17:15:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:11 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')]} 17:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:11 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')]} 17:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:11 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 0x7f6508a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, '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': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', '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 17:15:11 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 17:15:11 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 17:15:11 INFO - Using env: {'DISPLAY': ':0', 17:15:11 INFO - 'HOME': '/home/cltbld', 17:15:11 INFO - 'LANG': 'en_US.UTF-8', 17:15:11 INFO - 'LANGUAGE': 'en_US:en', 17:15:11 INFO - 'LOGNAME': 'cltbld', 17:15:11 INFO - 'MAIL': '/var/mail/cltbld', 17:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:11 INFO - 'MOZ_NO_REMOTE': '1', 17:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:11 INFO - 'NO_EM_RESTART': '1', 17:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:11 INFO - 'PWD': '/builds/slave/test', 17:15:11 INFO - 'SHELL': '/bin/bash', 17:15:11 INFO - 'SHLVL': '1', 17:15:11 INFO - 'TERM': 'linux', 17:15:11 INFO - 'TMOUT': '86400', 17:15:11 INFO - 'USER': 'cltbld', 17:15:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:11 INFO - '_': '/tools/buildbot/bin/python'} 17:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:11 INFO - Running setup.py (path:/tmp/pip-NXNzyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:11 INFO - Running setup.py (path:/tmp/pip-2sKPVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:11 INFO - Running setup.py (path:/tmp/pip-5JswnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:12 INFO - Running setup.py (path:/tmp/pip-dPR1ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:12 INFO - Running setup.py (path:/tmp/pip-KRxSLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:12 INFO - Running setup.py (path:/tmp/pip-wXIxZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:12 INFO - Running setup.py (path:/tmp/pip-e4Yb9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:12 INFO - Running setup.py (path:/tmp/pip-Y2P01s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:12 INFO - Running setup.py (path:/tmp/pip-Tm48yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:12 INFO - Running setup.py (path:/tmp/pip-rHWH1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:12 INFO - Running setup.py (path:/tmp/pip-BpUYXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:12 INFO - Running setup.py (path:/tmp/pip-er2Sbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:12 INFO - Running setup.py (path:/tmp/pip-lqhKQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:12 INFO - Running setup.py (path:/tmp/pip-DOxOZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:12 INFO - Running setup.py (path:/tmp/pip-mHTN9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:12 INFO - Running setup.py (path:/tmp/pip-PNYv_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:12 INFO - Running setup.py (path:/tmp/pip-AHs97z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:12 INFO - Running setup.py install for manifestparser 17:15:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:15:13 INFO - Running setup.py install for mozcrash 17:15:13 INFO - Running setup.py install for mozdebug 17:15:13 INFO - Running setup.py install for mozdevice 17:15:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:15:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:15:13 INFO - Running setup.py install for mozfile 17:15:13 INFO - Running setup.py install for mozhttpd 17:15:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:15:13 INFO - Running setup.py install for mozinfo 17:15:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:15:13 INFO - Running setup.py install for mozInstall 17:15:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:15:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:15:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:15:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:15:13 INFO - Running setup.py install for mozleak 17:15:13 INFO - Running setup.py install for mozlog 17:15:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:15:14 INFO - Running setup.py install for moznetwork 17:15:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:15:14 INFO - Running setup.py install for mozprocess 17:15:14 INFO - Running setup.py install for mozprofile 17:15:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:15:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:15:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:15:14 INFO - Running setup.py install for mozrunner 17:15:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:15:14 INFO - Running setup.py install for mozscreenshot 17:15:14 INFO - Running setup.py install for moztest 17:15:14 INFO - Running setup.py install for mozversion 17:15:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:15:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:14 INFO - Cleaning up... 17:15:14 INFO - Return code: 0 17:15:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:14 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 0x7f6508a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, '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': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', '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 17:15:14 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 17:15:14 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 17:15:14 INFO - Using env: {'DISPLAY': ':0', 17:15:14 INFO - 'HOME': '/home/cltbld', 17:15:14 INFO - 'LANG': 'en_US.UTF-8', 17:15:14 INFO - 'LANGUAGE': 'en_US:en', 17:15:14 INFO - 'LOGNAME': 'cltbld', 17:15:14 INFO - 'MAIL': '/var/mail/cltbld', 17:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:14 INFO - 'MOZ_NO_REMOTE': '1', 17:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:14 INFO - 'NO_EM_RESTART': '1', 17:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:14 INFO - 'PWD': '/builds/slave/test', 17:15:14 INFO - 'SHELL': '/bin/bash', 17:15:14 INFO - 'SHLVL': '1', 17:15:14 INFO - 'TERM': 'linux', 17:15:14 INFO - 'TMOUT': '86400', 17:15:14 INFO - 'USER': 'cltbld', 17:15:14 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:14 INFO - '_': '/tools/buildbot/bin/python'} 17:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:15 INFO - Running setup.py (path:/tmp/pip-gYvZ71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:15 INFO - Running setup.py (path:/tmp/pip-V58Zmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:15 INFO - Running setup.py (path:/tmp/pip-Sz4W47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:15 INFO - Running setup.py (path:/tmp/pip-FCs8kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:15 INFO - Running setup.py (path:/tmp/pip-861reP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:15 INFO - Running setup.py (path:/tmp/pip-znavPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:15 INFO - Running setup.py (path:/tmp/pip-WXCBpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:15 INFO - Running setup.py (path:/tmp/pip-dqQUlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:15 INFO - Running setup.py (path:/tmp/pip-BQuda1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:15 INFO - Running setup.py (path:/tmp/pip-4pjP0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:15 INFO - Running setup.py (path:/tmp/pip-immdYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:15 INFO - Running setup.py (path:/tmp/pip-gymPlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:15 INFO - Running setup.py (path:/tmp/pip-3zq7qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:15 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)) 17:15:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:15 INFO - Running setup.py (path:/tmp/pip-p3Fov9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:16 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)) 17:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:16 INFO - Running setup.py (path:/tmp/pip-RozNi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:16 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)) 17:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:16 INFO - Running setup.py (path:/tmp/pip-5Kanbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:16 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)) 17:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:16 INFO - Running setup.py (path:/tmp/pip-MV3s5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:16 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)) 17:15:16 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)) 17:15:16 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)) 17:15:16 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)) 17:15:16 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)) 17:15:16 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)) 17:15:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:16 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 17:15:16 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 17:15:16 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 17:15:16 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 17:15:16 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 17:15:16 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 17:15:18 INFO - Downloading blessings-1.6.tar.gz 17:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:18 INFO - Installing collected packages: blessings 17:15:18 INFO - Running setup.py install for blessings 17:15:18 INFO - Successfully installed blessings 17:15:18 INFO - Cleaning up... 17:15:18 INFO - Return code: 0 17:15:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:15:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:18 INFO - Reading from file tmpfile_stdout 17:15:18 INFO - Current package versions: 17:15:18 INFO - argparse == 1.2.1 17:15:18 INFO - blessings == 1.6 17:15:18 INFO - blobuploader == 1.2.4 17:15:18 INFO - docopt == 0.6.1 17:15:18 INFO - manifestparser == 1.1 17:15:18 INFO - mozInstall == 1.12 17:15:18 INFO - mozcrash == 0.17 17:15:18 INFO - mozdebug == 0.1 17:15:18 INFO - mozdevice == 0.48 17:15:18 INFO - mozfile == 1.2 17:15:18 INFO - mozhttpd == 0.7 17:15:18 INFO - mozinfo == 0.9 17:15:18 INFO - mozleak == 0.1 17:15:18 INFO - mozlog == 3.1 17:15:18 INFO - moznetwork == 0.27 17:15:18 INFO - mozprocess == 0.22 17:15:18 INFO - mozprofile == 0.28 17:15:18 INFO - mozrunner == 6.11 17:15:18 INFO - mozscreenshot == 0.1 17:15:18 INFO - mozsystemmonitor == 0.0 17:15:18 INFO - moztest == 0.7 17:15:18 INFO - mozversion == 1.4 17:15:18 INFO - psutil == 3.1.1 17:15:18 INFO - requests == 1.2.3 17:15:18 INFO - wsgiref == 0.1.2 17:15:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:18 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')]} 17:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:18 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')]} 17:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:18 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 0x7f6508a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, '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': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', '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 17:15:18 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 17:15:18 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 17:15:18 INFO - Using env: {'DISPLAY': ':0', 17:15:18 INFO - 'HOME': '/home/cltbld', 17:15:18 INFO - 'LANG': 'en_US.UTF-8', 17:15:18 INFO - 'LANGUAGE': 'en_US:en', 17:15:18 INFO - 'LOGNAME': 'cltbld', 17:15:18 INFO - 'MAIL': '/var/mail/cltbld', 17:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:18 INFO - 'MOZ_NO_REMOTE': '1', 17:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:18 INFO - 'NO_EM_RESTART': '1', 17:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:18 INFO - 'PWD': '/builds/slave/test', 17:15:18 INFO - 'SHELL': '/bin/bash', 17:15:18 INFO - 'SHLVL': '1', 17:15:18 INFO - 'TERM': 'linux', 17:15:18 INFO - 'TMOUT': '86400', 17:15:18 INFO - 'USER': 'cltbld', 17:15:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:18 INFO - '_': '/tools/buildbot/bin/python'} 17:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:18 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)) 17:15:18 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)) 17:15:18 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)) 17:15:18 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)) 17:15:18 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)) 17:15:18 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)) 17:15:18 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)) 17:15:18 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)) 17:15:18 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)) 17:15:18 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)) 17:15:18 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)) 17:15:18 INFO - Cleaning up... 17:15:18 INFO - Return code: 0 17:15:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:15:18 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')]} 17:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:18 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')]} 17:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:18 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 0x7f6508a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, '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': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', '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 17:15:18 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 17:15:18 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 17:15:18 INFO - Using env: {'DISPLAY': ':0', 17:15:18 INFO - 'HOME': '/home/cltbld', 17:15:18 INFO - 'LANG': 'en_US.UTF-8', 17:15:18 INFO - 'LANGUAGE': 'en_US:en', 17:15:18 INFO - 'LOGNAME': 'cltbld', 17:15:18 INFO - 'MAIL': '/var/mail/cltbld', 17:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:18 INFO - 'MOZ_NO_REMOTE': '1', 17:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:18 INFO - 'NO_EM_RESTART': '1', 17:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:18 INFO - 'PWD': '/builds/slave/test', 17:15:18 INFO - 'SHELL': '/bin/bash', 17:15:18 INFO - 'SHLVL': '1', 17:15:18 INFO - 'TERM': 'linux', 17:15:18 INFO - 'TMOUT': '86400', 17:15:18 INFO - 'USER': 'cltbld', 17:15:18 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:18 INFO - '_': '/tools/buildbot/bin/python'} 17:15:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:19 INFO - Downloading/unpacking jsonschema 17:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:20 INFO - Downloading/unpacking functools32 (from jsonschema) 17:15:20 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 17:15:20 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 17:15:20 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 17:15:20 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 17:15:20 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 17:15:20 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 17:15:21 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:21 INFO - warning: no files found matching '*.txt' 17:15:21 INFO - no previously-included directories found matching 'build' 17:15:21 INFO - no previously-included directories found matching 'dist' 17:15:21 INFO - no previously-included directories found matching '.git*' 17:15:21 INFO - Installing collected packages: jsonschema, functools32 17:15:21 INFO - Running setup.py install for functools32 17:15:21 INFO - warning: no files found matching '*.txt' 17:15:21 INFO - no previously-included directories found matching 'build' 17:15:21 INFO - no previously-included directories found matching 'dist' 17:15:21 INFO - no previously-included directories found matching '.git*' 17:15:21 INFO - Successfully installed jsonschema functools32 17:15:21 INFO - Cleaning up... 17:15:21 INFO - Return code: 0 17:15:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:15:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6508a3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffa5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, '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': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', '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 17:15:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:15:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:15:21 INFO - Using env: {'DISPLAY': ':0', 17:15:21 INFO - 'HOME': '/home/cltbld', 17:15:21 INFO - 'LANG': 'en_US.UTF-8', 17:15:21 INFO - 'LANGUAGE': 'en_US:en', 17:15:21 INFO - 'LOGNAME': 'cltbld', 17:15:21 INFO - 'MAIL': '/var/mail/cltbld', 17:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:21 INFO - 'MOZ_NO_REMOTE': '1', 17:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:21 INFO - 'NO_EM_RESTART': '1', 17:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:21 INFO - 'PWD': '/builds/slave/test', 17:15:21 INFO - 'SHELL': '/bin/bash', 17:15:21 INFO - 'SHLVL': '1', 17:15:21 INFO - 'TERM': 'linux', 17:15:21 INFO - 'TMOUT': '86400', 17:15:21 INFO - 'USER': 'cltbld', 17:15:21 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:21 INFO - '_': '/tools/buildbot/bin/python'} 17:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:21 INFO - Downloading/unpacking flake8 17:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:15:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:15:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:15:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:24 INFO - no previously-included directories found matching 'docs/_build' 17:15:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:15:24 INFO - Running setup.py install for pep8 17:15:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:15:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:15:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:15:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:15:24 INFO - no previously-included directories found matching 'docs/_build' 17:15:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:15:24 INFO - Cleaning up... 17:15:24 INFO - Return code: 0 17:15:24 INFO - Running post-action listener: _resource_record_post_action 17:15:24 INFO - Running post-action listener: _start_resource_monitoring 17:15:24 INFO - Starting resource monitoring. 17:15:24 INFO - ##### 17:15:24 INFO - ##### Running install step. 17:15:24 INFO - ##### 17:15:24 INFO - Running pre-action listener: _resource_record_pre_action 17:15:24 INFO - Running main action method: install 17:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:24 INFO - Reading from file tmpfile_stdout 17:15:24 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:15:24 INFO - Reading from file tmpfile_stdout 17:15:24 INFO - Output received: 17:15:24 INFO - Usage: mozinstall [options] installer 17:15:24 INFO - Options: 17:15:24 INFO - -h, --help show this help message and exit 17:15:24 INFO - -d DEST, --destination=DEST 17:15:24 INFO - Directory to install application into. [default: 17:15:24 INFO - "/builds/slave/test"] 17:15:24 INFO - --app=APP Application being installed. [default: firefox] 17:15:24 INFO - mkdir: /builds/slave/test/build/application 17:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:15:41 INFO - Reading from file tmpfile_stdout 17:15:41 INFO - Output received: 17:15:41 INFO - /builds/slave/test/build/application/firefox/firefox 17:15:41 INFO - Running post-action listener: _resource_record_post_action 17:15:41 INFO - ##### 17:15:41 INFO - ##### Running run-tests step. 17:15:41 INFO - ##### 17:15:41 INFO - Running pre-action listener: _resource_record_pre_action 17:15:41 INFO - Running main action method: run_tests 17:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:15:41 INFO - Python 2.7.3 17:15:41 INFO - Return code: 0 17:15:41 INFO - grabbing minidump binary from tooltool 17:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:15:41 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 0x1089410>, '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 0x108a310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:15:41 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 17:15:41 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 17:15:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:15:41 INFO - Return code: 0 17:15:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:15:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:15:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:15:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:15:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:15:42 INFO - Return code: 0 17:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 17:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 17:15:42 INFO - Using env: {'DISPLAY': ':0', 17:15:42 INFO - 'HOME': '/home/cltbld', 17:15:42 INFO - 'LANG': 'en_US.UTF-8', 17:15:42 INFO - 'LANGUAGE': 'en_US:en', 17:15:42 INFO - 'LOGNAME': 'cltbld', 17:15:42 INFO - 'MAIL': '/var/mail/cltbld', 17:15:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:42 INFO - 'MOZ_NO_REMOTE': '1', 17:15:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:42 INFO - 'NO_EM_RESTART': '1', 17:15:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:42 INFO - 'PWD': '/builds/slave/test', 17:15:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:42 INFO - 'SHELL': '/bin/bash', 17:15:42 INFO - 'SHLVL': '1', 17:15:42 INFO - 'TERM': 'linux', 17:15:42 INFO - 'TMOUT': '86400', 17:15:42 INFO - 'USER': 'cltbld', 17:15:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910', 17:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:42 INFO - '_': '/tools/buildbot/bin/python'} 17:15:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 17:15:42 INFO - mozversion application_buildid: 20160424143014 17:15:42 INFO - mozversion application_changeset: 7e35addd4309d83144512aa27eccb15d72ec1291 17:15:42 INFO - mozversion application_display_name: Nightly 17:15:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:15:42 INFO - mozversion application_name: Firefox 17:15:42 INFO - mozversion application_remotingname: firefox 17:15:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:15:42 INFO - mozversion application_vendor: Mozilla 17:15:42 INFO - mozversion application_version: 48.0a1 17:15:42 INFO - mozversion platform_buildid: 20160424143014 17:15:42 INFO - mozversion platform_changeset: 7e35addd4309d83144512aa27eccb15d72ec1291 17:15:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:15:42 INFO - mozversion platform_version: 48.0a1 17:15:42 INFO - using testdate: 1461543342 17:15:42 INFO - actual date: 1461543342 17:15:42 INFO - starting webserver on 'localhost:51106' 17:15:42 INFO - SUITE-START | Running 2 tests 17:15:42 INFO - TEST-START | dromaeo_css 17:15:42 INFO - operating with platform_type : linux_ 17:15:42 INFO - Initialising browser for dromaeo_css test... 17:15:42 INFO - TEST-INFO | started process 6527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRxwPGE/profile http://localhost:51106/getInfo.html) 17:15:46 INFO - PROCESS | 6527 | 17:15:46 INFO - PROCESS | 6527 | (process:6597): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:15:47 INFO - PROCESS | 6527 | __metrics Screen width/height:1600/1200 17:15:47 INFO - PROCESS | 6527 | colorDepth:24 17:15:47 INFO - PROCESS | 6527 | Browser inner width/height: 1024/697 17:15:47 INFO - PROCESS | 6527 | __metrics 17:15:48 ERROR - PROCESS | 6527 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:15:48 INFO - TEST-INFO | 6527: exit 0 17:15:48 INFO - Browser initialized. 17:15:48 INFO - Running cycle 1/1 for dromaeo_css test... 17:15:48 INFO - TEST-INFO | started process 6648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRxwPGE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:50 INFO - PROCESS | 6648 | 17:15:50 INFO - PROCESS | 6648 | (process:6707): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:16:00 INFO - PROCESS | 6648 | RSS: Main: 164564992 17:16:00 INFO - PROCESS | 6648 | 17:16:50 INFO - PROCESS | 6648 | 1461543410260 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] 17:18:57 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51106/tests/dromaeo/cssquery-ext.html) 17:18:58 INFO - PROCESS | 6648 | RSS: Main: 169377792 17:18:58 INFO - PROCESS | 6648 | 17:22:00 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-ext.html (next: http://localhost:51106/tests/dromaeo/cssquery-jquery.html) 17:22:00 INFO - PROCESS | 6648 | RSS: Main: 166080512 17:22:00 INFO - PROCESS | 6648 | 17:25:02 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51106/tests/dromaeo/cssquery-mootools.html) 17:25:03 INFO - PROCESS | 6648 | RSS: Main: 166576128 17:25:03 INFO - PROCESS | 6648 | 17:28:04 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51106/tests/dromaeo/cssquery-prototype.html) 17:28:05 INFO - PROCESS | 6648 | RSS: Main: 164065280 17:28:05 INFO - PROCESS | 6648 | 17:31:07 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51106/tests/dromaeo/cssquery-yui.html) 17:31:08 INFO - PROCESS | 6648 | RSS: Main: 165076992 17:31:08 INFO - PROCESS | 6648 | 17:34:10 INFO - PROCESS | 6648 | Cycle 1(1): loaded http://localhost:51106/tests/dromaeo/cssquery-yui.html (next: http://localhost:51106/tests/dromaeo/cssquery-dojo.html) 17:34:11 INFO - PROCESS | 6648 | RSS: Main: 167157760 17:34:11 INFO - PROCESS | 6648 | 17:34:11 INFO - PROCESS | 6648 | __start_tp_report 17:34:11 INFO - PROCESS | 6648 | _x_x_mozilla_page_load 17:34:11 INFO - PROCESS | 6648 | _x_x_mozilla_page_load_details 17:34:11 INFO - PROCESS | 6648 | |i|pagename|runs| 17:34:11 INFO - PROCESS | 6648 | |0;dojo.html;3153.353562519683;3186.617605887294;3219.8229097399635;3222.1622378181664;3235.9191020224494;5442.482964118412;5447.673139611626;5452.591055670826;5454;5460.945390546093;5380;5436.075867102592;5470.781168753245;5472.945270547303;5564.86087847804;4929.433115191745;4984.501549845023;5035.823746168885;5043.697378157304;5107.7956881724685;88.87798754842481;4924.384451943507;5011.523905228997;5017.147084995559;5056.873578160557;4875.146849301358;4909.239067944474;4953.578945789613;4964.180910149821;4992.051510213048;4913.434954980187;4928.975355123237;4939.431965323962;4946.1344264753525;4980.850574482772;4914.066327397783;4923.458419573844;4931.96428749963;4975.7512124394;4983.875403114951;5331.093714068617;5349.812756553541;5361.624686271963;5370.140777475585;5406.053940560426;5820.650760954356;5831.154482599999;5834.941650583524;5838.328592211908;5886.470217680387;5751.597388182829;5868.706564671749;5902.468777809975;5937.584369094165;5973.223480947492;5461.399246082928;5501.642393244426;5503.091989821674;5505.9724701376235;5511.917321240185;5915.319738230159;5957.642541447441;5987.101934709741;6005.189299444606;6024.427679370453;5683.857903552444;5738.311402631627;5744.51171650406;5776.480116789509;5800.970995145081;5786.913196302059;5796.043652797325;5808.5933984621515;5813.069908814569;5816.621919575214;5687.971560142173;5771.480566749013;5779.508741756914;5780.421957804186;5784.4504772046585;5678.375378708339;5739.397363276879;5795.88408231833;5797.971010144923;5825.155352473867;4377.1683380157665;4398.692091553625;4404.911901761947;4450.621697155713;4474.172278128557;3927.509061367329;3937.17319362937;3951.68386529077;3978.960210397859;3999.9400008999887;5408.161734931092;5480.808171713971;5506.724663766796;5521.116621340647;5566.025945459609;5791.218185544982;5815.127730840323;5820.708964551755;5832.854178645568;5844.912326315109;5396.865078372994;5462.918056229159;5484.862878428071;5506.256655351476;5525.972370138124;4944.579710724629;4950.504949505093;4977;4980.402351717817;5008.699478031257;5974.492168165754;5975.343010538943;5986.670733109634;5986.760529578768;6034.336223015464;5686.891056244075;5821.563382746226;5854.795082172103;5918.112283157388;5935.732892019783;6030.065339872327;6037.939620603738;6044.304904935989;6044.667543285162;6053.788117416046;5735.54115670737;5755.798547050833;5756.1941328214925;5763.308402991668;5765.654060756368;5749.1663708762835;5760.164776107525;5799.2750906136735;5813.157092221689;5819.592628516132;5707.286589176353;5707.971460142673;5726.685032323262;5733.3406658234835;5739.71301434935;5510.504054635102;5647.068233741386;5657.3776884543495;5702.914456283242;5709.543236540983;5546.140348246028;5551.8889622208135;5571.415001424792;5579.386267510489;5581.079121944834;5667.688277144632;5687.60186786921;5700.971495142498;5727.570432217683;5777.971110144423;5533.750981205936;5614.550835933197;5649.858753531194;5651.463111004448;5654.378018417889 17:34:11 INFO - PROCESS | 6648 | |1;ext.html;602.8010756450371;636.9044643303507;656.661819163131;657.8388294867758;666.4501786026527;32354.838225808897;33143.502847457305;37414.81292593537;38593.8070309648;38723.612763872356;41558.37662435058;42348.36477452833;42430.575694243045;42439.575604243946;42592.574074259246;8577.914220857789;8807.16331948467;8827.823443531126;8832.867506987368;8834.823303533958;8693.13068693132;8745.300375969908;8748.081451447602;8793.736187914341;8820.250278726317;9062.320325975545;9117.49853758043;9121.270298376114;9168.633254669805;9189.908100918972;9004.189622933935;9053.547322633875;9056.366054376163;9058.094190580889;9063.59213835379;8833.690820821304;8865.601047952858;8951.865722014176;8954.23888969432;8961.372703910729;41595.58404415947;41754.79122604398;41959.7902010491;42043;42130.1573968522;3534.169470174507;3731.925361492782;3992.740471869319;4086.4483294755123;4320.719153255029;32281;32935.17662058468;32963;33100;33177.3364532708;4233.1956928183545;4328.394024836525;4335.674824388184;4392.05570802279;4409.845655402078;305774;307419;309006.45496772596;309119;309216;57480.71259643675;57496;57668.423315766304;57741.71129144327;57772;64659.353406465336;65115.348846510926;65594.34405655882;65821.34178658153;66096;16971;17199.31202751901;17266.22301996413;17303.56741081483;17337.133143342784;13161.078724489385;13189.142705724098;13329;13335.533256335983;13337.599872003855;19070.2371905125;19143.52141196481;19249.51876203078;19801.30695425653;20040.799592004187;6948.583085014915;7107.502474826816;7118.288171182944;7297.671604777692;7449.962750186214;1040.4237580066206;1041.557338131291;1047.554789214596;1105.6296140792924;1121.7924683933497;31732.20669483235;31805.681943180734;31828.681713183036;32234.516482252784;32805.17987050295;1115.7991561519004;1121.9887801121884;1163.5055101581793;1166.8016437205695;1218.256863313378;16936.322547098225;16968;16980.235889385007;17260.309587616353;17379.565510862078;507926;515998;516142;516604;525152;57395.713021434625;58521.70739146277;58810.41189588049;58903;59095.70452147798;1391.0540832234178;1399.2024546008881;1402.9438822447191;1420.1479112532397;1423.0750012491756;31014.534781977836;31420.68579314269;31465;32503.837480812446;32630.34739305248;50434.49565504445;50450.24324635207;50795;50852.491475084775;51024.48975510346;405215;412172;412495;413598;413723;27787;28016.859915701105;28195.43609127765;28231.71768282373;28248.85875570609;47296.52703472921;48169.759151204016;48230.75884620554;48243;48829.755851220514;40436.59563404446;41018;41140.177196455305;41170.176596468504;42682.146357072066;40447.79776101101;41076.178476430905;41850.79074604608;42061.36907946444;42093.0117379023;40450.1909961805;40729.59270407258;41142.58857411388;41407.585924141575;41979.7901010493;35237.471437928965;36741.26517469689;37510.43734343933;37665.43501847529;37782;28185.295367615974;28566.285842854097;28613.551690474334;28902.819750742856;29110.854445727637 17:34:11 INFO - PROCESS | 6648 | |2;jquery.html;397.94826672532577;401.31775980832595;407.95716449772794;408.1632653061224;414.0394285258202;17782.82217177828;18434;18715.251389944402;18771.4368568943;19467;18042.368517101902;18307.450776476693;18410.907945460254;19145.71281430776;19363.515912102204;5482.068048431766;5532.1425179097105;5556.666600004012;5574.665520068809;5613.46672066153;5469.781208751645;5610.495055445009;5652.717364131798;5655.688937108457;5686.800961966332;5444.502761740513;5551.750171242304;5604.271444712182;5606.747696353654;5628.605997580151;5555.722213889309;5556.416576259516;5587.720613969285;5595.38450770415;5599.356074051496;4787.281907713836;5043.394792624872;5058.215976523608;5068.214426763858;5070.2141168119;21811.23660671869;22437.887810561006;22596.322110336718;22937.885310573507;23033;740.3632875726871;1072.8229842076048;2257.8758168300737;2297.9425514362106;2703.7558826174227;14245.715085698332;14255.857441425556;14447.855521444757;14455.710885782331;14714.55856324312;1818.8453981411596;1875.268645228362;1971.3593082248326;1990.64168449679;1993.3421970749619;76331.23668763296;79233;81540.59229703873;81893;82501.58749206275;10812.94593527043;11157.553697851996;11289.266197697123;11339.659810205707;11513.999999999833;15862.44481443167;15881.841181588035;15983.520494385188;15997.920010400107;16041.438549650706;8204.917950820534;8408.663653453916;8481.40630155883;8500.65997360111;8504.872426913602;7899.684012639545;7914.643841027168;7917.7624671259955;7992.760217193493;8045.758627241192;4741.312509686076;4756.6432517561325;4787.473377928494;4878.682885612424;4910.8772280693265;1918.8081191880701;1973.506623344164;1973.842092632586;1999.9200031998848;2007.3375785990588;958.3195930889008;1039.1738567838586;1084.1706094837455;1117.0951529261324;1128.0749785176076;18849.528761781065;19109.904450477938;19236.134373952926;19369.4189174325;19620.803791962182;1056.102313033915;1075.2634445404922;1079.4656644960637;1093.8577984861918;1097.2922465010024;10579.471026448648;10979.451027448755;10990.17573681977;11002.779944401067;11008.559657613605;436948;443363;443966;444010;450524;89369.55315223512;96540;96891;97504;98822.5058874701;980.5048450532436;991.1674193677345;993.980120397588;996.8853581838036;1049.454283772434;16489.505314840095;17120.657586847945;17144.82855171482;17279.3952211672;17595.208215630584;33480.1629959253;38707.41938870863;39100.80449597734;39156.80421597874;40273.395899062125;55406.72296638491;55473;55654;55761;56109.71945140411;8396.412251142361;8412.579371031547;8608.268297194809;8695.043545209895;8912.33157513176;12553.686157846127;13327.600171994856;13518.526851560147;13630.93184534071;13761.655958600715;11884.405779710807;12009.279443233434;12080.637580872588;12101.25068513614;12101.334426606269;11468;11744.647660570197;11893.345865977455;11935.582254621047;12144.939275303566;10716.571337146426;11963.461644225858;12344.876551234373;12388.876111238773;12396.442160102997;8563.785905352166;8657.913420865963;8668;8677.132286771272;8733.563321833755;9953.850692239766;10640.84038739404;10758.677239682822;10769;10792.676219713421 17:34:11 INFO - PROCESS | 6648 | |3;mootools.html;1478.3051965576183;1490.0835985868691;1625.666738318644;1755.271562301645;1756.5784211789166;7717.72987945422;8152.5516096614665;8280.461769984946;8491.150884911505;8502.617382217799;8243.381746369032;8317.75046748597;8323.209295116969;8350.164983501647;8364.83270334593;2331.801796847266;2357.0807385119815;2360.0205914545445;2364.9645255321184;2366.420227044368;2339.087755775249;2357.5638506876285;2389.4265376309736;2399.2682231919257;2406.5186962607463;2295.5294164696197;2308.0998410619786;2319.5476882008015;2374.548835721216;2390.9838318714565;2336.7546407627297;2337.041812856729;2341.637046257833;2362.196853069956;2380.1907351500486;2314.745378008418;2323.303009097281;2332.090484710964;2350.4006478348083;2356.4697942962866;8493.787655308604;8574.099719529422;8652.740417787476;8655.307575393954;8671.653133874637;5223.791048358061;5406.297181366397;5428.4842939920645;5431.212474191259;5431.701256430894;3577.3203091412547;3589.5333606631234;3611.747177697562;3615.4215325547784;3616.6383361663884;1141.6917432293317;1143.9256448330916;1155.156735583029;1157.3056166300153;1164.5341863254682;11501.13741469393;11519.193656444053;11551.653450396501;11600.129990250765;11601.709957251136;4601.194790911577;4665.4168228971375;4780.378550788375;4828.565429111397;4845.781939812647;9884.061014203638;9916.7024989249;9926.553305101288;9950.850737238947;9975.401475911469;5352.330958630171;5366.060939335601;5370.812021579226;5380.3274590676165;5400.783968641211;4303.182395344875;4790.928136077961;4897.1674815281485;4931.50684931504;4933.309336692866;3939.7045221608496;3957.940630890539;4003.319435695939;4050.5341885683524;4136.4415803866095;1294.3851670456645;1307.6796184934751;1309.6267563744286;1311.6327428319894;1329.7805862032849;907.4056492997097;1017.4404077757351;1018.251585084962;1041.57295508841;1048.7273308939577;5781.682007489629;5842.182094506772;5998.280206375263;6012.338642749294;6064.575479716465;453.5351264953449;458.65829956682484;459.9701019433726;461.8822200338892;467.28272102322774;4052.8986775330263;4196.601322874383;4220.683448741357;4230.1539692061715;4246.129543443587;10110.797784044278;10384.688459346231;10404.635837745642;10428.582856685647;10542.420166890895;10062.245331600014;10296.07335339823;10432;10484.842727359095;10491.370517768959;7812.296893279632;7835.138134805167;7894.368450524059;7967.521948683097;7984.161663025415;5706.771729130788;5744.224529688438;5787.768489260382;5814.709264536672;5931.584789064724;9295.11696388842;9343.34596578233;9835.803283934425;9836.262280328861;10005.349652272578;9375.390599611004;9619.951900240454;9744.75638109053;9799.461029643153;9817.410955342702;6893.172819261721;7240.927590724236;7366.189719130998;7471.215522370073;7480.139783924918;8005.199480052182;8020.117787043304;8054.154313796967;8080.87878681832;8122.309603683753;7169.211386747349;7418.96290518544;7479.513831600929;7509.962450187714;7511.248875112445;7253.274672532704;7285;7350.309428831291;7445.888311675221;7450.701971921062;7053.083099197277;7053.4004609608755;7077.115360579927;7086.39765619928;7094.893576596252;5203.673063368817;5328.973355133355;5372.167314066326;5479.397266300624;5579.358373787067;5275.657082289639;5366.973165134149;5416.75624596902;5438.646487978427;5442.510174084351 17:34:11 INFO - PROCESS | 6648 | |4;prototype.html;333.2485245770786;339.78423700949895;343.8710483568662;346.02421172294123;349.7079938251559;5967.343592204854;6041.879162416754;6073.9674255376585;6099.146119543268;6135.6625385603775;5976.3724808895095;5987.790427335044;6024;6035;6041.577089603718;4146.979265103685;4443.333499974998;4535.092981403716;4571.794269257892;4577.633789296849;4541.909161816761;4566.1552612766745;4616.97691511542;4650.511696271894;4662.557057079572;4573.862784116465;4611.815527378901;4613;4618.960733834894;4627.606653434462;4459.44256967879;4579.335996280554;4593.793279302406;4608.262677971526;4614.261718125117;4036.5156181258435;4041.4948131483566;4060.5736397678115;4066.552679205285;4084.1831633673382;5772.509336706343;5802.12968054791;5814.854628634318;5844.415558444164;5861.648301101947;5182.248573956793;5308.6549374290935;5308.849915784113;5321.787128514855;5363.839084827461;6254;6266.49868010558;6276.3409841966395;6301.936980630181;6305.747770089191;4498.865034048984;4501.41481607389;4512;4513.097380523908;4520.434945631796;6265.122882796412;6367.458766004896;6403.7438502459845;6611.371919667672;6611.669416529155;4564.657650676212;4583.152116858392;4598.977005114953;4602.3786788783755;4606;4634.374359461497;4638.234691275969;4642.489326174118;4656.16189085961;4665.720056796603;5217.217417387346;5227;5323.095073837457;5327.627066105413;5330.093884039723;6324.33594472583;6324.679543239744;6368.968155159195;6385.584936979081;6392.9360706392345;1622.9775241597717;1636.7872176617202;1637.5333030086367;1638.3937942961181;1645.695546323934;1081.3079629037422;1093.1582681335328;1096.7751610919743;1097.9451027448595;1119.5186069989982;6049.0926361046195;6108.541859360477;6115.388461153938;6151.72317245725;6155.292141403706;6452.548321617535;6506.967465162644;6521.282658907517;6540.738370465223;6586.476235214138;5837.503812176013;6183.103449999725;6191.938080619136;6204.441600255908;6211.596246243979;3527.770694904823;3528.541289632383;3531;3534.8939531814085;3561.269939662363;6565.573237739532;6857.931420685829;6874.2782007889455;6891.310868913069;6895.207051189077;6788.76239331621;6792.490563207779;6811.386975172259;6812.4550035997;6830.282820303896;6681.131452911188;6779.966100169468;6836.418904393182;6862.107925969592;6929.203141638675;6543.738250469928;6613.14029176204;6639.336066393322;6642.4686025118845;6661.833454163685;6306.337834527309;6414.358564143548;6493.935060649333;6544.574602650812;6558.770443034471;6865.038894554867;6906.551074180162;6912.930870691229;6912.930870691229;6915.550489218386;4481.417415735934;4492.707973981681;4496.955030449784;4505.459344878635;4524.751138687404;6442.549021568632;6646.8005959821285;6649.368310010541;6660.933390666225;6667.066610674412;6425.357464253537;6441.259255185713;6458.451031662361;6461.224653041665;6461.547691661726;6285.5600107992;6449.484041276781;6476.255230648348;6486.286508483969;6528.640924749185;6308.905366419599;6324.3991820776955;6342.968285158545;6361.236651601837;6378.1070650108095;6188.628682279078;6485.708143133476;6496.577722448026;6498.772542960974;6522.608643481406;6358.427741503287;6374.904376434264;6380.617162970237;6382.20222472191;6406.455451286693 17:34:11 INFO - PROCESS | 6648 | |5;yui.html;766.2529034191667;806.98320116653;831.6132998155858;857.1300130367678;859.1365677494117;13165.473381064747;13186.274754888489;13260.668483287922;13467.461301547939;13987.23070231138;13437.193768373905;13464.057515973886;13511.121777084483;13531.120477168977;13608.251546164956;825.6656054298019;853.9487630742175;854.3080105114877;857.3055824781916;858.1804376820153;850.2177996243471;854.5897968974865;856.3491746272815;857.4426622695236;859.5573279760928;885.8272636835819;889.1286539191597;890.3856339125982;890.6526454682679;892.5091199840094;877.473515890467;880.3265501891059;880.4717169698162;885.7298523950193;888.5646033443599;640.9519286053518;644.4586547300244;645.1902861908322;645.4771634975684;647.2847503508649;14361.138331700131;14363.640908977255;14367.640808979755;14453;14487.637809054753;14327.498537551135;14360.64098397538;14446.349914253884;14486.275686215753;14523.564293071226;9985.650502232387;10137.087662110445;10173.949130254376;10246.692599222035;10391.376517408904;3777.3200823851694;3805.2009078093633;3813.389857622795;3862.053796819769;3930.449737036817;57444.138337924545;57757.7112114441;57778.42221577815;58133;58231;10113.898861011443;10201.132903703268;10278.22913281507;10388.117010054078;10537.367757934548;20178.697319540217;20414.081366338254;20444.693329600068;20462;20465.07907144182;7861.921380786233;7967.2431119043595;8102.594870256464;8160.673573057011;8246.711365102192;4395.274779661384;4490.685652004328;4515.841945531956;4539.205639013159;4663.790129444184;3378.797272163678;3469.3755124077907;3475.165960169541;3476.1309672581856;3566.8573257069947;676.3067855448106;677.0318444624136;682.5802131688976;683.5761827666779;689.0904006711094;740.7851723000269;757.6666266842572;759.8860170974398;771.733751855609;787.3858589890701;8609.69866054685;8854.203121718947;8957.088946092546;8967.148120928501;9211.986681465167;759.525296689569;775.8913752074714;781.0744268042274;790.7390561114819;800.6557180412362;3914.8629797957506;3939.6060393960374;3992.876277705429;4011.679065674739;4130.256553820341;64752.35247647557;65341.67329163324;65418.67290663516;66095.66952165305;66892.66553667298;56030.15954760682;56132;57336.42663573311;57848.71075644679;58259.12611310834;50233;50469.49530504648;52469.212961805606;52852.47147528552;53552;7748.9612551939135;7754.457187997012;7903.407244456574;8065.516069035877;8131.512109273463;29453.171087758456;29977.850110749307;30106;31239.531407029368;31422.842885785423;40985;41695.37456938209;41836.37245441382;41910.16179676451;42095.57904420917;11611.767764644828;11631.185816992729;11742.58900938463;11936.880631193577;11988.160828742253;12573.811392828931;12692.492300307884;12705.809412858629;12723.618291451272;12776;12245;12331.136820422484;12413.565525206574;12490.812637810623;12576.371181440709;11475.48360323804;11650.88349116498;11801.645950621494;11943.104267179822;12004.039676825658;10972.451377431256;11474.139439542234;12147.088968327234;12243.265404075784;12613.684657883627;9595.376300540442;9840.45877476717;9979.550920208752;9990.500474976077;10151.238657100599;10533.104686101768;10591.788164236827;10722.463876806285;10722.51748671296;10738.73153171177 17:34:11 INFO - PROCESS | 6648 | __end_tp_report 17:34:11 INFO - PROCESS | 6648 | __start_cc_report 17:34:11 INFO - PROCESS | 6648 | _x_x_mozilla_cycle_collect,336 17:34:11 INFO - PROCESS | 6648 | __end_cc_report 17:34:11 INFO - PROCESS | 6648 | __startTimestamp1461544451070__endTimestamp 17:34:11 INFO - PROCESS | 6648 | 17:34:11 INFO - PROCESS | 6648 | ------- Summary: start ------- 17:34:11 INFO - PROCESS | 6648 | Number of tests: 6 17:34:11 INFO - PROCESS | 6648 | 17:34:11 INFO - PROCESS | 6648 | [#0] dojo.html Cycles:165 Average:5377.84 Median:5647.07 stddev:735.04 (13.0%) stddev-sans-first:716.28 17:34:11 INFO - PROCESS | 6648 | Values: 3153.4 3186.6 3219.8 3222.2 3235.9 5442.5 5447.7 5452.6 5454.0 5460.9 5380.0 5436.1 5470.8 5472.9 5564.9 4929.4 4984.5 5035.8 5043.7 5107.8 88.9 4924.4 5011.5 5017.1 5056.9 4875.1 4909.2 4953.6 4964.2 4992.1 4913.4 4929.0 4939.4 4946.1 4980.9 4914.1 4923.5 4932.0 4975.8 4983.9 5331.1 5349.8 5361.6 5370.1 5406.1 5820.7 5831.2 5834.9 5838.3 5886.5 5751.6 5868.7 5902.5 5937.6 5973.2 5461.4 5501.6 5503.1 5506.0 5511.9 5915.3 5957.6 5987.1 6005.2 6024.4 5683.9 5738.3 5744.5 5776.5 5801.0 5786.9 5796.0 5808.6 5813.1 5816.6 5688.0 5771.5 5779.5 5780.4 5784.5 5678.4 5739.4 5795.9 5798.0 5825.2 4377.2 4398.7 4404.9 4450.6 4474.2 3927.5 3937.2 3951.7 3979.0 3999.9 5408.2 5480.8 5506.7 5521.1 5566.0 5791.2 5815.1 5820.7 5832.9 5844.9 5396.9 5462.9 5484.9 5506.3 5526.0 4944.6 4950.5 4977.0 4980.4 5008.7 5974.5 5975.3 5986.7 5986.8 6034.3 5686.9 5821.6 5854.8 5918.1 5935.7 6030.1 6037.9 6044.3 6044.7 6053.8 5735.5 5755.8 5756.2 5763.3 5765.7 5749.2 5760.2 5799.3 5813.2 5819.6 5707.3 5708.0 5726.7 5733.3 5739.7 5510.5 5647.1 5657.4 5702.9 5709.5 5546.1 5551.9 5571.4 5579.4 5581.1 5667.7 5687.6 5701.0 5727.6 5778.0 5533.8 5614.6 5649.9 5651.5 5654.4 17:34:11 INFO - PROCESS | 6648 | 17:34:11 INFO - PROCESS | 6648 | [#1] ext.html Cycles:180 Average:57847.83 Median:413046.50 stddev:111371.72 (27.0%) stddev-sans-first:111601.22 17:34:11 INFO - PROCESS | 6648 | Values: 602.8 636.9 656.7 657.8 666.5 32354.8 33143.5 37414.8 38593.8 38723.6 41558.4 42348.4 42430.6 42439.6 42592.6 8577.9 8807.2 8827.8 8832.9 8834.8 8693.1 8745.3 8748.1 8793.7 8820.3 9062.3 9117.5 9121.3 9168.6 9189.9 9004.2 9053.5 9056.4 9058.1 9063.6 8833.7 8865.6 8951.9 8954.2 8961.4 41595.6 41754.8 41959.8 42043.0 42130.2 3534.2 3731.9 3992.7 4086.4 4320.7 32281.0 32935.2 32963.0 33100.0 33177.3 4233.2 4328.4 4335.7 4392.1 4409.8 305774.0 307419.0 309006.5 309119.0 309216.0 57480.7 57496.0 57668.4 57741.7 57772.0 64659.4 65115.3 65594.3 65821.3 66096.0 16971.0 17199.3 17266.2 17303.6 17337.1 13161.1 13189.1 13329.0 13335.5 13337.6 19070.2 19143.5 19249.5 19801.3 20040.8 6948.6 7107.5 7118.3 7297.7 7450.0 1040.4 1041.6 1047.6 1105.6 1121.8 31732.2 31805.7 31828.7 32234.5 32805.2 1115.8 1122.0 1163.5 1166.8 1218.3 16936.3 16968.0 16980.2 17260.3 17379.6 507926.0 515998.0 516142.0 516604.0 525152.0 57395.7 58521.7 58810.4 58903.0 59095.7 1391.1 1399.2 1402.9 1420.1 1423.1 31014.5 31420.7 31465.0 32503.8 32630.3 50434.5 50450.2 50795.0 50852.5 51024.5 405215.0 412172.0 412495.0 413598.0 413723.0 27787.0 28016.9 28195.4 28231.7 28248.9 47296.5 48169.8 48230.8 48243.0 48829.8 40436.6 41018.0 41140.2 41170.2 42682.1 40447.8 41076.2 41850.8 42061.4 42093.0 40450.2 40729.6 41142.6 41407.6 41979.8 35237.5 36741.3 37510.4 37665.4 37782.0 28185.3 28566.3 28613.6 28902.8 29110.9 17:34:11 INFO - PROCESS | 6648 | 17:34:11 INFO - PROCESS | 6648 | [#2] jquery.html Cycles:180 Average:27701.69 Median:12665.47 stddev:73479.37 (580.2%) stddev-sans-first:73656.90 17:34:11 INFO - PROCESS | 6648 | Values: 397.9 401.3 408.0 408.2 414.0 17782.8 18434.0 18715.3 18771.4 19467.0 18042.4 18307.5 18410.9 19145.7 19363.5 5482.1 5532.1 5556.7 5574.7 5613.5 5469.8 5610.5 5652.7 5655.7 5686.8 5444.5 5551.8 5604.3 5606.7 5628.6 5555.7 5556.4 5587.7 5595.4 5599.4 4787.3 5043.4 5058.2 5068.2 5070.2 21811.2 22437.9 22596.3 22937.9 23033.0 740.4 1072.8 2257.9 2297.9 2703.8 14245.7 14255.9 14447.9 14455.7 14714.6 1818.8 1875.3 1971.4 1990.6 1993.3 76331.2 79233.0 81540.6 81893.0 82501.6 10812.9 11157.6 11289.3 11339.7 11514.0 15862.4 15881.8 15983.5 15997.9 16041.4 8204.9 8408.7 8481.4 8500.7 8504.9 7899.7 7914.6 7917.8 7992.8 8045.8 4741.3 4756.6 4787.5 4878.7 4910.9 1918.8 1973.5 1973.8 1999.9 2007.3 958.3 1039.2 1084.2 1117.1 1128.1 18849.5 19109.9 19236.1 19369.4 19620.8 1056.1 1075.3 1079.5 1093.9 1097.3 10579.5 10979.5 10990.2 11002.8 11008.6 436948.0 443363.0 443966.0 444010.0 450524.0 89369.6 96540.0 96891.0 97504.0 98822.5 980.5 991.2 994.0 996.9 1049.5 16489.5 17120.7 17144.8 17279.4 17595.2 33480.2 38707.4 39100.8 39156.8 40273.4 55406.7 55473.0 55654.0 55761.0 56109.7 8396.4 8412.6 8608.3 8695.0 8912.3 12553.7 13327.6 13518.5 13630.9 13761.7 11884.4 12009.3 12080.6 12101.3 12101.3 11468.0 11744.6 11893.3 11935.6 12144.9 10716.6 11963.5 12344.9 12388.9 12396.4 8563.8 8657.9 8668.0 8677.1 8733.6 9953.9 10640.8 10758.7 10769.0 10792.7 17:34:11 INFO - PROCESS | 6648 | 17:34:11 INFO - PROCESS | 6648 | [#3] mootools.html Cycles:180 Average:5658.61 Median:5213.73 stddev:3098.28 (59.4%) stddev-sans-first:3091.05 17:34:11 INFO - PROCESS | 6648 | Values: 1478.3 1490.1 1625.7 1755.3 1756.6 7717.7 8152.6 8280.5 8491.2 8502.6 8243.4 8317.8 8323.2 8350.2 8364.8 2331.8 2357.1 2360.0 2365.0 2366.4 2339.1 2357.6 2389.4 2399.3 2406.5 2295.5 2308.1 2319.5 2374.5 2391.0 2336.8 2337.0 2341.6 2362.2 2380.2 2314.7 2323.3 2332.1 2350.4 2356.5 8493.8 8574.1 8652.7 8655.3 8671.7 5223.8 5406.3 5428.5 5431.2 5431.7 3577.3 3589.5 3611.7 3615.4 3616.6 1141.7 1143.9 1155.2 1157.3 1164.5 11501.1 11519.2 11551.7 11600.1 11601.7 4601.2 4665.4 4780.4 4828.6 4845.8 9884.1 9916.7 9926.6 9950.9 9975.4 5352.3 5366.1 5370.8 5380.3 5400.8 4303.2 4790.9 4897.2 4931.5 4933.3 3939.7 3957.9 4003.3 4050.5 4136.4 1294.4 1307.7 1309.6 1311.6 1329.8 907.4 1017.4 1018.3 1041.6 1048.7 5781.7 5842.2 5998.3 6012.3 6064.6 453.5 458.7 460.0 461.9 467.3 4052.9 4196.6 4220.7 4230.2 4246.1 10110.8 10384.7 10404.6 10428.6 10542.4 10062.2 10296.1 10432.0 10484.8 10491.4 7812.3 7835.1 7894.4 7967.5 7984.2 5706.8 5744.2 5787.8 5814.7 5931.6 9295.1 9343.3 9835.8 9836.3 10005.3 9375.4 9620.0 9744.8 9799.5 9817.4 6893.2 7240.9 7366.2 7471.2 7480.1 8005.2 8020.1 8054.2 8080.9 8122.3 7169.2 7419.0 7479.5 7510.0 7511.2 7253.3 7285.0 7350.3 7445.9 7450.7 7053.1 7053.4 7077.1 7086.4 7094.9 5203.7 5329.0 5372.2 5479.4 5579.4 5275.7 5367.0 5416.8 5438.6 5442.5 17:34:11 INFO - PROCESS | 6648 | 17:34:11 INFO - PROCESS | 6648 | [#4] prototype.html Cycles:180 Average:5349.81 Median:6103.84 stddev:1610.32 (26.4%) stddev-sans-first:1570.20 17:34:11 INFO - PROCESS | 6648 | Values: 333.2 339.8 343.9 346.0 349.7 5967.3 6041.9 6074.0 6099.1 6135.7 5976.4 5987.8 6024.0 6035.0 6041.6 4147.0 4443.3 4535.1 4571.8 4577.6 4541.9 4566.2 4617.0 4650.5 4662.6 4573.9 4611.8 4613.0 4619.0 4627.6 4459.4 4579.3 4593.8 4608.3 4614.3 4036.5 4041.5 4060.6 4066.6 4084.2 5772.5 5802.1 5814.9 5844.4 5861.6 5182.2 5308.7 5308.8 5321.8 5363.8 6254.0 6266.5 6276.3 6301.9 6305.7 4498.9 4501.4 4512.0 4513.1 4520.4 6265.1 6367.5 6403.7 6611.4 6611.7 4564.7 4583.2 4599.0 4602.4 4606.0 4634.4 4638.2 4642.5 4656.2 4665.7 5217.2 5227.0 5323.1 5327.6 5330.1 6324.3 6324.7 6369.0 6385.6 6392.9 1623.0 1636.8 1637.5 1638.4 1645.7 1081.3 1093.2 1096.8 1097.9 1119.5 6049.1 6108.5 6115.4 6151.7 6155.3 6452.5 6507.0 6521.3 6540.7 6586.5 5837.5 6183.1 6191.9 6204.4 6211.6 3527.8 3528.5 3531.0 3534.9 3561.3 6565.6 6857.9 6874.3 6891.3 6895.2 6788.8 6792.5 6811.4 6812.5 6830.3 6681.1 6780.0 6836.4 6862.1 6929.2 6543.7 6613.1 6639.3 6642.5 6661.8 6306.3 6414.4 6493.9 6544.6 6558.8 6865.0 6906.6 6912.9 6912.9 6915.6 4481.4 4492.7 4497.0 4505.5 4524.8 6442.5 6646.8 6649.4 6660.9 6667.1 6425.4 6441.3 6458.5 6461.2 6461.5 6285.6 6449.5 6476.3 6486.3 6528.6 6308.9 6324.4 6343.0 6361.2 6378.1 6188.6 6485.7 6496.6 6498.8 6522.6 6358.4 6374.9 6380.6 6382.2 6406.5 17:34:11 INFO - PROCESS | 6648 | 17:34:11 INFO - PROCESS | 6648 | [#5] yui.html Cycles:180 Average:14734.19 Median:4442.98 stddev:17612.14 (396.4%) stddev-sans-first:17630.31 17:34:11 INFO - PROCESS | 6648 | Values: 766.3 807.0 831.6 857.1 859.1 13165.5 13186.3 13260.7 13467.5 13987.2 13437.2 13464.1 13511.1 13531.1 13608.3 825.7 853.9 854.3 857.3 858.2 850.2 854.6 856.3 857.4 859.6 885.8 889.1 890.4 890.7 892.5 877.5 880.3 880.5 885.7 888.6 641.0 644.5 645.2 645.5 647.3 14361.1 14363.6 14367.6 14453.0 14487.6 14327.5 14360.6 14446.3 14486.3 14523.6 9985.7 10137.1 10173.9 10246.7 10391.4 3777.3 3805.2 3813.4 3862.1 3930.4 57444.1 57757.7 57778.4 58133.0 58231.0 10113.9 10201.1 10278.2 10388.1 10537.4 20178.7 20414.1 20444.7 20462.0 20465.1 7861.9 7967.2 8102.6 8160.7 8246.7 4395.3 4490.7 4515.8 4539.2 4663.8 3378.8 3469.4 3475.2 3476.1 3566.9 676.3 677.0 682.6 683.6 689.1 740.8 757.7 759.9 771.7 787.4 8609.7 8854.2 8957.1 8967.1 9212.0 759.5 775.9 781.1 790.7 800.7 3914.9 3939.6 3992.9 4011.7 4130.3 64752.4 65341.7 65418.7 66095.7 66892.7 56030.2 56132.0 57336.4 57848.7 58259.1 50233.0 50469.5 52469.2 52852.5 53552.0 7749.0 7754.5 7903.4 8065.5 8131.5 29453.2 29977.9 30106.0 31239.5 31422.8 40985.0 41695.4 41836.4 41910.2 42095.6 11611.8 11631.2 11742.6 11936.9 11988.2 12573.8 12692.5 12705.8 12723.6 12776.0 12245.0 12331.1 12413.6 12490.8 12576.4 11475.5 11650.9 11801.6 11943.1 12004.0 10972.5 11474.1 12147.1 12243.3 12613.7 9595.4 9840.5 9979.6 9990.5 10151.2 10533.1 10591.8 10722.5 10722.5 10738.7 17:34:11 INFO - PROCESS | 6648 | -------- Summary: end -------- 17:34:11 INFO - PROCESS | 6648 | 17:34:11 INFO - TEST-INFO | 6648: exit 0 17:34:11 INFO - TEST-OK | dromaeo_css | took 1109309ms 17:34:11 INFO - TEST-START | kraken 17:34:11 INFO - operating with platform_type : linux_ 17:34:11 INFO - Initialising browser for kraken test... 17:34:11 INFO - TEST-INFO | started process 6876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgO4lyM/profile http://localhost:51106/getInfo.html) 17:34:15 INFO - PROCESS | 6876 | 17:34:15 INFO - PROCESS | 6876 | (process:6942): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:34:16 INFO - PROCESS | 6876 | __metrics Screen width/height:1600/1200 17:34:16 INFO - PROCESS | 6876 | colorDepth:24 17:34:16 INFO - PROCESS | 6876 | Browser inner width/height: 1024/697 17:34:16 INFO - PROCESS | 6876 | __metrics 17:34:16 ERROR - PROCESS | 6876 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:34:17 INFO - TEST-INFO | 6876: exit 0 17:34:17 INFO - Browser initialized. 17:34:17 INFO - Running cycle 1/1 for kraken test... 17:34:17 INFO - TEST-INFO | started process 6993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgO4lyM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:19 INFO - PROCESS | 6993 | 17:34:19 INFO - PROCESS | 6993 | (process:7053): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:34:29 INFO - PROCESS | 6993 | RSS: Main: 164409344 17:34:29 INFO - PROCESS | 6993 | 17:34:31 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51106/tests/kraken/driver.html?testName=audio-beat-detection) 17:34:32 INFO - PROCESS | 6993 | RSS: Main: 169377792 17:34:32 INFO - PROCESS | 6993 | 17:34:35 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51106/tests/kraken/driver.html?testName=audio-dft) 17:34:36 INFO - PROCESS | 6993 | RSS: Main: 172494848 17:34:36 INFO - PROCESS | 6993 | 17:34:38 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51106/tests/kraken/driver.html?testName=audio-fft) 17:34:39 INFO - PROCESS | 6993 | RSS: Main: 163418112 17:34:39 INFO - PROCESS | 6993 | 17:34:41 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51106/tests/kraken/driver.html?testName=audio-oscillator) 17:34:42 INFO - PROCESS | 6993 | RSS: Main: 163692544 17:34:42 INFO - PROCESS | 6993 | 17:34:44 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:34:45 INFO - PROCESS | 6993 | RSS: Main: 164347904 17:34:45 INFO - PROCESS | 6993 | 17:34:48 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51106/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:48 INFO - PROCESS | 6993 | RSS: Main: 164270080 17:34:48 INFO - PROCESS | 6993 | 17:34:52 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51106/tests/kraken/driver.html?testName=imaging-desaturate) 17:34:52 INFO - PROCESS | 6993 | RSS: Main: 164638720 17:34:52 INFO - PROCESS | 6993 | 17:34:55 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51106/tests/kraken/driver.html?testName=json-parse-financial) 17:34:56 INFO - PROCESS | 6993 | RSS: Main: 167608320 17:34:56 INFO - PROCESS | 6993 | 17:34:57 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:34:58 INFO - PROCESS | 6993 | RSS: Main: 167608320 17:34:58 INFO - PROCESS | 6993 | 17:35:00 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:00 INFO - PROCESS | 6993 | RSS: Main: 167583744 17:35:00 INFO - PROCESS | 6993 | 17:35:02 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:03 INFO - PROCESS | 6993 | RSS: Main: 167149568 17:35:03 INFO - PROCESS | 6993 | 17:35:06 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:06 INFO - PROCESS | 6993 | RSS: Main: 168464384 17:35:06 INFO - PROCESS | 6993 | 17:35:09 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:10 INFO - PROCESS | 6993 | RSS: Main: 167600128 17:35:10 INFO - PROCESS | 6993 | 17:35:11 INFO - PROCESS | 6993 | Cycle 1(1): loaded http://localhost:51106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51106/tests/kraken/driver.html?testName=ai-astar) 17:35:12 INFO - PROCESS | 6993 | RSS: Main: 169123840 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | __start_tp_report 17:35:12 INFO - PROCESS | 6993 | _x_x_mozilla_page_load 17:35:12 INFO - PROCESS | 6993 | _x_x_mozilla_page_load_details 17:35:12 INFO - PROCESS | 6993 | |i|pagename|runs| 17:35:12 INFO - PROCESS | 6993 | |0;ai-astar;111;107;110;110;110;123;110;112;110;111 17:35:12 INFO - PROCESS | 6993 | |1;audio-beat-detection;162;126;156;174;129;165;162;134;191;131 17:35:12 INFO - PROCESS | 6993 | |2;audio-dft;161;163;162;162;161;163;176;164;165;164 17:35:12 INFO - PROCESS | 6993 | |3;audio-fft;76;77;72;154;79;75;77;76;173;78 17:35:12 INFO - PROCESS | 6993 | |4;audio-oscillator;92;92;150;93;92;93;155;93;92;148 17:35:12 INFO - PROCESS | 6993 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;118;117;117 17:35:12 INFO - PROCESS | 6993 | |6;imaging-darkroom;146;146;147;146;149;147;148;147;146;146 17:35:12 INFO - PROCESS | 6993 | |7;imaging-desaturate;96;95;95;96;100;99;96;95;96;96 17:35:12 INFO - PROCESS | 6993 | |8;json-parse-financial;59;58;58;58;57;61;61;79;56;55 17:35:12 INFO - PROCESS | 6993 | |9;json-stringify-tinderbox;61;59;61;61;61;60;60;60;61;60 17:35:12 INFO - PROCESS | 6993 | |10;stanford-crypto-aes;76;85;79;78;86;77;77;77;78;79 17:35:12 INFO - PROCESS | 6993 | |11;stanford-crypto-ccm;128;125;126;136;134;124;130;129;157;127 17:35:12 INFO - PROCESS | 6993 | |12;stanford-crypto-pbkdf2;170;163;169;162;171;162;162;161;164;162 17:35:12 INFO - PROCESS | 6993 | |13;stanford-crypto-sha256-iterative;69;67;68;68;68;67;68;68;67;68 17:35:12 INFO - PROCESS | 6993 | __end_tp_report 17:35:12 INFO - PROCESS | 6993 | __start_cc_report 17:35:12 INFO - PROCESS | 6993 | _x_x_mozilla_cycle_collect,895 17:35:12 INFO - PROCESS | 6993 | __end_cc_report 17:35:12 INFO - PROCESS | 6993 | __startTimestamp1461544512053__endTimestamp 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | ------- Summary: start ------- 17:35:12 INFO - PROCESS | 6993 | Number of tests: 14 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#0] ai-astar Cycles:10 Average:111.40 Median:110.50 stddev:4.27 (3.9%) stddev-sans-first:4.53 17:35:12 INFO - PROCESS | 6993 | Values: 111.0 107.0 110.0 110.0 110.0 123.0 110.0 112.0 110.0 111.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:162.00 stddev:21.98 (13.6%) stddev-sans-first:23.08 17:35:12 INFO - PROCESS | 6993 | Values: 162.0 126.0 156.0 174.0 129.0 165.0 162.0 134.0 191.0 131.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:4.38 (2.7%) stddev-sans-first:4.50 17:35:12 INFO - PROCESS | 6993 | Values: 161.0 163.0 162.0 162.0 161.0 163.0 176.0 164.0 165.0 164.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.50 stddev:37.11 (48.5%) stddev-sans-first:38.80 17:35:12 INFO - PROCESS | 6993 | Values: 76.0 77.0 72.0 154.0 79.0 75.0 77.0 76.0 173.0 78.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:92.00 stddev:28.35 (30.8%) stddev-sans-first:29.31 17:35:12 INFO - PROCESS | 6993 | Values: 92.0 92.0 150.0 93.0 92.0 93.0 155.0 93.0 92.0 148.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:35:12 INFO - PROCESS | 6993 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 17:35:12 INFO - PROCESS | 6993 | Values: 146.0 146.0 147.0 146.0 149.0 147.0 148.0 147.0 146.0 146.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.71 (1.8%) stddev-sans-first:1.81 17:35:12 INFO - PROCESS | 6993 | Values: 96.0 95.0 95.0 96.0 100.0 99.0 96.0 95.0 96.0 96.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:58.50 stddev:6.88 (11.8%) stddev-sans-first:7.28 17:35:12 INFO - PROCESS | 6993 | Values: 59.0 58.0 58.0 58.0 57.0 61.0 61.0 79.0 56.0 55.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 17:35:12 INFO - PROCESS | 6993 | Values: 61.0 59.0 61.0 61.0 61.0 60.0 60.0 60.0 61.0 60.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.50 stddev:3.46 (4.4%) stddev-sans-first:3.47 17:35:12 INFO - PROCESS | 6993 | Values: 76.0 85.0 79.0 78.0 86.0 77.0 77.0 77.0 78.0 79.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:129.50 stddev:9.70 (7.5%) stddev-sans-first:10.20 17:35:12 INFO - PROCESS | 6993 | Values: 128.0 125.0 126.0 136.0 134.0 124.0 130.0 129.0 157.0 127.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:163.50 stddev:3.84 (2.3%) stddev-sans-first:3.54 17:35:12 INFO - PROCESS | 6993 | Values: 170.0 163.0 169.0 162.0 171.0 162.0 162.0 161.0 164.0 162.0 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - PROCESS | 6993 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 17:35:12 INFO - PROCESS | 6993 | Values: 69.0 67.0 68.0 68.0 68.0 67.0 68.0 68.0 67.0 68.0 17:35:12 INFO - PROCESS | 6993 | -------- Summary: end -------- 17:35:12 INFO - PROCESS | 6993 | 17:35:12 INFO - TEST-INFO | 6993: exit 0 17:35:13 INFO - TEST-OK | kraken | took 61261ms 17:35:13 INFO - SUITE-END | took 1170s 17:35:13 INFO - Completed test suite (00:19:30) 17:35:13 INFO - javascript benchmark 17:35:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.353562519683, 3186.617605887294, 3219.8229097399635, 3222.1622378181664, 3235.9191020224494, 5442.482964118412, 5447.673139611626, 5452.591055670826, 5454.0, 5460.945390546093, 5380.0, 5436.075867102592, 5470.781168753245, 5472.945270547303, 5564.86087847804, 4929.433115191745, 4984.501549845023, 5035.823746168885, 5043.697378157304, 5107.7956881724685, 88.87798754842481, 4924.384451943507, 5011.523905228997, 5017.147084995559, 5056.873578160557, 4875.146849301358, 4909.239067944474, 4953.578945789613, 4964.180910149821, 4992.051510213048, 4913.434954980187, 4928.975355123237, 4939.431965323962, 4946.1344264753525, 4980.850574482772, 4914.066327397783, 4923.458419573844, 4931.96428749963, 4975.7512124394, 4983.875403114951, 5331.093714068617, 5349.812756553541, 5361.624686271963, 5370.140777475585, 5406.053940560426, 5820.650760954356, 5831.154482599999, 5834.941650583524, 5838.328592211908, 5886.470217680387, 5751.597388182829, 5868.706564671749, 5902.468777809975, 5937.584369094165, 5973.223480947492, 5461.399246082928, 5501.642393244426, 5503.091989821674, 5505.9724701376235, 5511.917321240185, 5915.319738230159, 5957.642541447441, 5987.101934709741, 6005.189299444606, 6024.427679370453, 5683.857903552444, 5738.311402631627, 5744.51171650406, 5776.480116789509, 5800.970995145081, 5786.913196302059, 5796.043652797325, 5808.5933984621515, 5813.069908814569, 5816.621919575214, 5687.971560142173, 5771.480566749013, 5779.508741756914, 5780.421957804186, 5784.4504772046585, 5678.375378708339, 5739.397363276879, 5795.88408231833, 5797.971010144923, 5825.155352473867, 4377.1683380157665, 4398.692091553625, 4404.911901761947, 4450.621697155713, 4474.172278128557, 3927.509061367329, 3937.17319362937, 3951.68386529077, 3978.960210397859, 3999.9400008999887, 5408.161734931092, 5480.808171713971, 5506.724663766796, 5521.116621340647, 5566.025945459609, 5791.218185544982, 5815.127730840323, 5820.708964551755, 5832.854178645568, 5844.912326315109, 5396.865078372994, 5462.918056229159, 5484.862878428071, 5506.256655351476, 5525.972370138124, 4944.579710724629, 4950.504949505093, 4977.0, 4980.402351717817, 5008.699478031257, 5974.492168165754, 5975.343010538943, 5986.670733109634, 5986.760529578768, 6034.336223015464, 5686.891056244075, 5821.563382746226, 5854.795082172103, 5918.112283157388, 5935.732892019783, 6030.065339872327, 6037.939620603738, 6044.304904935989, 6044.667543285162, 6053.788117416046, 5735.54115670737, 5755.798547050833, 5756.1941328214925, 5763.308402991668, 5765.654060756368, 5749.1663708762835, 5760.164776107525, 5799.2750906136735, 5813.157092221689, 5819.592628516132, 5707.286589176353, 5707.971460142673, 5726.685032323262, 5733.3406658234835, 5739.71301434935, 5510.504054635102, 5647.068233741386, 5657.3776884543495, 5702.914456283242, 5709.543236540983, 5546.140348246028, 5551.8889622208135, 5571.415001424792, 5579.386267510489, 5581.079121944834, 5667.688277144632, 5687.60186786921, 5700.971495142498, 5727.570432217683, 5777.971110144423, 5533.750981205936, 5614.550835933197, 5649.858753531194, 5651.463111004448, 5654.378018417889], "value": 5331.665630346139, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.8010756450371, 636.9044643303507, 656.661819163131, 657.8388294867758, 666.4501786026527, 32354.838225808897, 33143.502847457305, 37414.81292593537, 38593.8070309648, 38723.612763872356, 41558.37662435058, 42348.36477452833, 42430.575694243045, 42439.575604243946, 42592.574074259246, 8577.914220857789, 8807.16331948467, 8827.823443531126, 8832.867506987368, 8834.823303533958, 8693.13068693132, 8745.300375969908, 8748.081451447602, 8793.736187914341, 8820.250278726317, 9062.320325975545, 9117.49853758043, 9121.270298376114, 9168.633254669805, 9189.908100918972, 9004.189622933935, 9053.547322633875, 9056.366054376163, 9058.094190580889, 9063.59213835379, 8833.690820821304, 8865.601047952858, 8951.865722014176, 8954.23888969432, 8961.372703910729, 41595.58404415947, 41754.79122604398, 41959.7902010491, 42043.0, 42130.1573968522, 3534.169470174507, 3731.925361492782, 3992.740471869319, 4086.4483294755123, 4320.719153255029, 32281.0, 32935.17662058468, 32963.0, 33100.0, 33177.3364532708, 4233.1956928183545, 4328.394024836525, 4335.674824388184, 4392.05570802279, 4409.845655402078, 305774.0, 307419.0, 309006.45496772596, 309119.0, 309216.0, 57480.71259643675, 57496.0, 57668.423315766304, 57741.71129144327, 57772.0, 64659.353406465336, 65115.348846510926, 65594.34405655882, 65821.34178658153, 66096.0, 16971.0, 17199.31202751901, 17266.22301996413, 17303.56741081483, 17337.133143342784, 13161.078724489385, 13189.142705724098, 13329.0, 13335.533256335983, 13337.599872003855, 19070.2371905125, 19143.52141196481, 19249.51876203078, 19801.30695425653, 20040.799592004187, 6948.583085014915, 7107.502474826816, 7118.288171182944, 7297.671604777692, 7449.962750186214, 1040.4237580066206, 1041.557338131291, 1047.554789214596, 1105.6296140792924, 1121.7924683933497, 31732.20669483235, 31805.681943180734, 31828.681713183036, 32234.516482252784, 32805.17987050295, 1115.7991561519004, 1121.9887801121884, 1163.5055101581793, 1166.8016437205695, 1218.256863313378, 16936.322547098225, 16968.0, 16980.235889385007, 17260.309587616353, 17379.565510862078, 507926.0, 515998.0, 516142.0, 516604.0, 525152.0, 57395.713021434625, 58521.70739146277, 58810.41189588049, 58903.0, 59095.70452147798, 1391.0540832234178, 1399.2024546008881, 1402.9438822447191, 1420.1479112532397, 1423.0750012491756, 31014.534781977836, 31420.68579314269, 31465.0, 32503.837480812446, 32630.34739305248, 50434.49565504445, 50450.24324635207, 50795.0, 50852.491475084775, 51024.48975510346, 405215.0, 412172.0, 412495.0, 413598.0, 413723.0, 27787.0, 28016.859915701105, 28195.43609127765, 28231.71768282373, 28248.85875570609, 47296.52703472921, 48169.759151204016, 48230.75884620554, 48243.0, 48829.755851220514, 40436.59563404446, 41018.0, 41140.177196455305, 41170.176596468504, 42682.146357072066, 40447.79776101101, 41076.178476430905, 41850.79074604608, 42061.36907946444, 42093.0117379023, 40450.1909961805, 40729.59270407258, 41142.58857411388, 41407.585924141575, 41979.7901010493, 35237.471437928965, 36741.26517469689, 37510.43734343933, 37665.43501847529, 37782.0, 28185.295367615974, 28566.285842854097, 28613.551690474334, 28902.819750742856, 29110.854445727637], "value": 20179.000479893508, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.94826672532577, 401.31775980832595, 407.95716449772794, 408.1632653061224, 414.0394285258202, 17782.82217177828, 18434.0, 18715.251389944402, 18771.4368568943, 19467.0, 18042.368517101902, 18307.450776476693, 18410.907945460254, 19145.71281430776, 19363.515912102204, 5482.068048431766, 5532.1425179097105, 5556.666600004012, 5574.665520068809, 5613.46672066153, 5469.781208751645, 5610.495055445009, 5652.717364131798, 5655.688937108457, 5686.800961966332, 5444.502761740513, 5551.750171242304, 5604.271444712182, 5606.747696353654, 5628.605997580151, 5555.722213889309, 5556.416576259516, 5587.720613969285, 5595.38450770415, 5599.356074051496, 4787.281907713836, 5043.394792624872, 5058.215976523608, 5068.214426763858, 5070.2141168119, 21811.23660671869, 22437.887810561006, 22596.322110336718, 22937.885310573507, 23033.0, 740.3632875726871, 1072.8229842076048, 2257.8758168300737, 2297.9425514362106, 2703.7558826174227, 14245.715085698332, 14255.857441425556, 14447.855521444757, 14455.710885782331, 14714.55856324312, 1818.8453981411596, 1875.268645228362, 1971.3593082248326, 1990.64168449679, 1993.3421970749619, 76331.23668763296, 79233.0, 81540.59229703873, 81893.0, 82501.58749206275, 10812.94593527043, 11157.553697851996, 11289.266197697123, 11339.659810205707, 11513.999999999833, 15862.44481443167, 15881.841181588035, 15983.520494385188, 15997.920010400107, 16041.438549650706, 8204.917950820534, 8408.663653453916, 8481.40630155883, 8500.65997360111, 8504.872426913602, 7899.684012639545, 7914.643841027168, 7917.7624671259955, 7992.760217193493, 8045.758627241192, 4741.312509686076, 4756.6432517561325, 4787.473377928494, 4878.682885612424, 4910.8772280693265, 1918.8081191880701, 1973.506623344164, 1973.842092632586, 1999.9200031998848, 2007.3375785990588, 958.3195930889008, 1039.1738567838586, 1084.1706094837455, 1117.0951529261324, 1128.0749785176076, 18849.528761781065, 19109.904450477938, 19236.134373952926, 19369.4189174325, 19620.803791962182, 1056.102313033915, 1075.2634445404922, 1079.4656644960637, 1093.8577984861918, 1097.2922465010024, 10579.471026448648, 10979.451027448755, 10990.17573681977, 11002.779944401067, 11008.559657613605, 436948.0, 443363.0, 443966.0, 444010.0, 450524.0, 89369.55315223512, 96540.0, 96891.0, 97504.0, 98822.5058874701, 980.5048450532436, 991.1674193677345, 993.980120397588, 996.8853581838036, 1049.454283772434, 16489.505314840095, 17120.657586847945, 17144.82855171482, 17279.3952211672, 17595.208215630584, 33480.1629959253, 38707.41938870863, 39100.80449597734, 39156.80421597874, 40273.395899062125, 55406.72296638491, 55473.0, 55654.0, 55761.0, 56109.71945140411, 8396.412251142361, 8412.579371031547, 8608.268297194809, 8695.043545209895, 8912.33157513176, 12553.686157846127, 13327.600171994856, 13518.526851560147, 13630.93184534071, 13761.655958600715, 11884.405779710807, 12009.279443233434, 12080.637580872588, 12101.25068513614, 12101.334426606269, 11468.0, 11744.647660570197, 11893.345865977455, 11935.582254621047, 12144.939275303566, 10716.571337146426, 11963.461644225858, 12344.876551234373, 12388.876111238773, 12396.442160102997, 8563.785905352166, 8657.913420865963, 8668.0, 8677.132286771272, 8733.563321833755, 9953.850692239766, 10640.84038739404, 10758.677239682822, 10769.0, 10792.676219713421], "value": 9192.465217656521, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.3051965576183, 1490.0835985868691, 1625.666738318644, 1755.271562301645, 1756.5784211789166, 7717.72987945422, 8152.5516096614665, 8280.461769984946, 8491.150884911505, 8502.617382217799, 8243.381746369032, 8317.75046748597, 8323.209295116969, 8350.164983501647, 8364.83270334593, 2331.801796847266, 2357.0807385119815, 2360.0205914545445, 2364.9645255321184, 2366.420227044368, 2339.087755775249, 2357.5638506876285, 2389.4265376309736, 2399.2682231919257, 2406.5186962607463, 2295.5294164696197, 2308.0998410619786, 2319.5476882008015, 2374.548835721216, 2390.9838318714565, 2336.7546407627297, 2337.041812856729, 2341.637046257833, 2362.196853069956, 2380.1907351500486, 2314.745378008418, 2323.303009097281, 2332.090484710964, 2350.4006478348083, 2356.4697942962866, 8493.787655308604, 8574.099719529422, 8652.740417787476, 8655.307575393954, 8671.653133874637, 5223.791048358061, 5406.297181366397, 5428.4842939920645, 5431.212474191259, 5431.701256430894, 3577.3203091412547, 3589.5333606631234, 3611.747177697562, 3615.4215325547784, 3616.6383361663884, 1141.6917432293317, 1143.9256448330916, 1155.156735583029, 1157.3056166300153, 1164.5341863254682, 11501.13741469393, 11519.193656444053, 11551.653450396501, 11600.129990250765, 11601.709957251136, 4601.194790911577, 4665.4168228971375, 4780.378550788375, 4828.565429111397, 4845.781939812647, 9884.061014203638, 9916.7024989249, 9926.553305101288, 9950.850737238947, 9975.401475911469, 5352.330958630171, 5366.060939335601, 5370.812021579226, 5380.3274590676165, 5400.783968641211, 4303.182395344875, 4790.928136077961, 4897.1674815281485, 4931.50684931504, 4933.309336692866, 3939.7045221608496, 3957.940630890539, 4003.319435695939, 4050.5341885683524, 4136.4415803866095, 1294.3851670456645, 1307.6796184934751, 1309.6267563744286, 1311.6327428319894, 1329.7805862032849, 907.4056492997097, 1017.4404077757351, 1018.251585084962, 1041.57295508841, 1048.7273308939577, 5781.682007489629, 5842.182094506772, 5998.280206375263, 6012.338642749294, 6064.575479716465, 453.5351264953449, 458.65829956682484, 459.9701019433726, 461.8822200338892, 467.28272102322774, 4052.8986775330263, 4196.601322874383, 4220.683448741357, 4230.1539692061715, 4246.129543443587, 10110.797784044278, 10384.688459346231, 10404.635837745642, 10428.582856685647, 10542.420166890895, 10062.245331600014, 10296.07335339823, 10432.0, 10484.842727359095, 10491.370517768959, 7812.296893279632, 7835.138134805167, 7894.368450524059, 7967.521948683097, 7984.161663025415, 5706.771729130788, 5744.224529688438, 5787.768489260382, 5814.709264536672, 5931.584789064724, 9295.11696388842, 9343.34596578233, 9835.803283934425, 9836.262280328861, 10005.349652272578, 9375.390599611004, 9619.951900240454, 9744.75638109053, 9799.461029643153, 9817.410955342702, 6893.172819261721, 7240.927590724236, 7366.189719130998, 7471.215522370073, 7480.139783924918, 8005.199480052182, 8020.117787043304, 8054.154313796967, 8080.87878681832, 8122.309603683753, 7169.211386747349, 7418.96290518544, 7479.513831600929, 7509.962450187714, 7511.248875112445, 7253.274672532704, 7285.0, 7350.309428831291, 7445.888311675221, 7450.701971921062, 7053.083099197277, 7053.4004609608755, 7077.115360579927, 7086.39765619928, 7094.893576596252, 5203.673063368817, 5328.973355133355, 5372.167314066326, 5479.397266300624, 5579.358373787067, 5275.657082289639, 5366.973165134149, 5416.75624596902, 5438.646487978427, 5442.510174084351], "value": 4523.581714207197, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.2485245770786, 339.78423700949895, 343.8710483568662, 346.02421172294123, 349.7079938251559, 5967.343592204854, 6041.879162416754, 6073.9674255376585, 6099.146119543268, 6135.6625385603775, 5976.3724808895095, 5987.790427335044, 6024.0, 6035.0, 6041.577089603718, 4146.979265103685, 4443.333499974998, 4535.092981403716, 4571.794269257892, 4577.633789296849, 4541.909161816761, 4566.1552612766745, 4616.97691511542, 4650.511696271894, 4662.557057079572, 4573.862784116465, 4611.815527378901, 4613.0, 4618.960733834894, 4627.606653434462, 4459.44256967879, 4579.335996280554, 4593.793279302406, 4608.262677971526, 4614.261718125117, 4036.5156181258435, 4041.4948131483566, 4060.5736397678115, 4066.552679205285, 4084.1831633673382, 5772.509336706343, 5802.12968054791, 5814.854628634318, 5844.415558444164, 5861.648301101947, 5182.248573956793, 5308.6549374290935, 5308.849915784113, 5321.787128514855, 5363.839084827461, 6254.0, 6266.49868010558, 6276.3409841966395, 6301.936980630181, 6305.747770089191, 4498.865034048984, 4501.41481607389, 4512.0, 4513.097380523908, 4520.434945631796, 6265.122882796412, 6367.458766004896, 6403.7438502459845, 6611.371919667672, 6611.669416529155, 4564.657650676212, 4583.152116858392, 4598.977005114953, 4602.3786788783755, 4606.0, 4634.374359461497, 4638.234691275969, 4642.489326174118, 4656.16189085961, 4665.720056796603, 5217.217417387346, 5227.0, 5323.095073837457, 5327.627066105413, 5330.093884039723, 6324.33594472583, 6324.679543239744, 6368.968155159195, 6385.584936979081, 6392.9360706392345, 1622.9775241597717, 1636.7872176617202, 1637.5333030086367, 1638.3937942961181, 1645.695546323934, 1081.3079629037422, 1093.1582681335328, 1096.7751610919743, 1097.9451027448595, 1119.5186069989982, 6049.0926361046195, 6108.541859360477, 6115.388461153938, 6151.72317245725, 6155.292141403706, 6452.548321617535, 6506.967465162644, 6521.282658907517, 6540.738370465223, 6586.476235214138, 5837.503812176013, 6183.103449999725, 6191.938080619136, 6204.441600255908, 6211.596246243979, 3527.770694904823, 3528.541289632383, 3531.0, 3534.8939531814085, 3561.269939662363, 6565.573237739532, 6857.931420685829, 6874.2782007889455, 6891.310868913069, 6895.207051189077, 6788.76239331621, 6792.490563207779, 6811.386975172259, 6812.4550035997, 6830.282820303896, 6681.131452911188, 6779.966100169468, 6836.418904393182, 6862.107925969592, 6929.203141638675, 6543.738250469928, 6613.14029176204, 6639.336066393322, 6642.4686025118845, 6661.833454163685, 6306.337834527309, 6414.358564143548, 6493.935060649333, 6544.574602650812, 6558.770443034471, 6865.038894554867, 6906.551074180162, 6912.930870691229, 6912.930870691229, 6915.550489218386, 4481.417415735934, 4492.707973981681, 4496.955030449784, 4505.459344878635, 4524.751138687404, 6442.549021568632, 6646.8005959821285, 6649.368310010541, 6660.933390666225, 6667.066610674412, 6425.357464253537, 6441.259255185713, 6458.451031662361, 6461.224653041665, 6461.547691661726, 6285.5600107992, 6449.484041276781, 6476.255230648348, 6486.286508483969, 6528.640924749185, 6308.905366419599, 6324.3991820776955, 6342.968285158545, 6361.236651601837, 6378.1070650108095, 6188.628682279078, 6485.708143133476, 6496.577722448026, 6498.772542960974, 6522.608643481406, 6358.427741503287, 6374.904376434264, 6380.617162970237, 6382.20222472191, 6406.455451286693], "value": 4828.777294163461, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [766.2529034191667, 806.98320116653, 831.6132998155858, 857.1300130367678, 859.1365677494117, 13165.473381064747, 13186.274754888489, 13260.668483287922, 13467.461301547939, 13987.23070231138, 13437.193768373905, 13464.057515973886, 13511.121777084483, 13531.120477168977, 13608.251546164956, 825.6656054298019, 853.9487630742175, 854.3080105114877, 857.3055824781916, 858.1804376820153, 850.2177996243471, 854.5897968974865, 856.3491746272815, 857.4426622695236, 859.5573279760928, 885.8272636835819, 889.1286539191597, 890.3856339125982, 890.6526454682679, 892.5091199840094, 877.473515890467, 880.3265501891059, 880.4717169698162, 885.7298523950193, 888.5646033443599, 640.9519286053518, 644.4586547300244, 645.1902861908322, 645.4771634975684, 647.2847503508649, 14361.138331700131, 14363.640908977255, 14367.640808979755, 14453.0, 14487.637809054753, 14327.498537551135, 14360.64098397538, 14446.349914253884, 14486.275686215753, 14523.564293071226, 9985.650502232387, 10137.087662110445, 10173.949130254376, 10246.692599222035, 10391.376517408904, 3777.3200823851694, 3805.2009078093633, 3813.389857622795, 3862.053796819769, 3930.449737036817, 57444.138337924545, 57757.7112114441, 57778.42221577815, 58133.0, 58231.0, 10113.898861011443, 10201.132903703268, 10278.22913281507, 10388.117010054078, 10537.367757934548, 20178.697319540217, 20414.081366338254, 20444.693329600068, 20462.0, 20465.07907144182, 7861.921380786233, 7967.2431119043595, 8102.594870256464, 8160.673573057011, 8246.711365102192, 4395.274779661384, 4490.685652004328, 4515.841945531956, 4539.205639013159, 4663.790129444184, 3378.797272163678, 3469.3755124077907, 3475.165960169541, 3476.1309672581856, 3566.8573257069947, 676.3067855448106, 677.0318444624136, 682.5802131688976, 683.5761827666779, 689.0904006711094, 740.7851723000269, 757.6666266842572, 759.8860170974398, 771.733751855609, 787.3858589890701, 8609.69866054685, 8854.203121718947, 8957.088946092546, 8967.148120928501, 9211.986681465167, 759.525296689569, 775.8913752074714, 781.0744268042274, 790.7390561114819, 800.6557180412362, 3914.8629797957506, 3939.6060393960374, 3992.876277705429, 4011.679065674739, 4130.256553820341, 64752.35247647557, 65341.67329163324, 65418.67290663516, 66095.66952165305, 66892.66553667298, 56030.15954760682, 56132.0, 57336.42663573311, 57848.71075644679, 58259.12611310834, 50233.0, 50469.49530504648, 52469.212961805606, 52852.47147528552, 53552.0, 7748.9612551939135, 7754.457187997012, 7903.407244456574, 8065.516069035877, 8131.512109273463, 29453.171087758456, 29977.850110749307, 30106.0, 31239.531407029368, 31422.842885785423, 40985.0, 41695.37456938209, 41836.37245441382, 41910.16179676451, 42095.57904420917, 11611.767764644828, 11631.185816992729, 11742.58900938463, 11936.880631193577, 11988.160828742253, 12573.811392828931, 12692.492300307884, 12705.809412858629, 12723.618291451272, 12776.0, 12245.0, 12331.136820422484, 12413.565525206574, 12490.812637810623, 12576.371181440709, 11475.48360323804, 11650.88349116498, 11801.645950621494, 11943.104267179822, 12004.039676825658, 10972.451377431256, 11474.139439542234, 12147.088968327234, 12243.265404075784, 12613.684657883627, 9595.376300540442, 9840.45877476717, 9979.550920208752, 9990.500474976077, 10151.238657100599, 10533.104686101768, 10591.788164236827, 10722.463876806285, 10722.51748671296, 10738.73153171177], "value": 6697.954028516548, "unit": "score"}], "name": "dromaeo_css", "value": 7245.743399668625, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 110.0, 110.0, 110.0, 123.0, 110.0, 112.0, 110.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 126.0, 156.0, 174.0, 129.0, 165.0, 162.0, 134.0, 191.0, 131.0], "value": 153.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 161.0, 163.0, 176.0, 164.0, 165.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 72.0, 154.0, 79.0, 75.0, 77.0, 76.0, 173.0, 78.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 150.0, 93.0, 92.0, 93.0, 155.0, 93.0, 92.0, 148.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 149.0, 147.0, 148.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 100.0, 99.0, 96.0, 95.0, 96.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 57.0, 61.0, 61.0, 79.0, 56.0, 55.0], "value": 60.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 85.0, 79.0, 78.0, 86.0, 77.0, 77.0, 77.0, 78.0, 79.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 126.0, 136.0, 134.0, 124.0, 130.0, 129.0, 157.0, 127.0], "value": 131.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 163.0, 169.0, 162.0, 171.0, 162.0, 162.0, 161.0, 164.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 67.0, 68.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1556.6, "alertThreshold": 2.0}]} 17:35:13 INFO - Return code: 0 17:35:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:35:13 ERROR - # TBPL SUCCESS # 17:35:13 INFO - Running post-action listener: _resource_record_post_action 17:35:13 INFO - Running post-run listener: _resource_record_post_run 17:35:14 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 196608; Write bytes: 291164160; Read time: 60; Write time: 199628 17:35:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 1294336; Read time: 0; Write time: 44 17:35:14 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 196608; Write bytes: 289869824; Read time: 60; Write time: 199584 17:35:14 INFO - Running post-run listener: _upload_blobber_files 17:35:14 INFO - Blob upload gear active. 17:35:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:14 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 17:35:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:35:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:35:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:15 INFO - (blobuploader) - INFO - Done attempting. 17:35:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:35:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:35:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:35:16 INFO - (blobuploader) - INFO - Done attempting. 17:35:16 INFO - (blobuploader) - INFO - Iteration through files over. 17:35:16 INFO - Return code: 0 17:35:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:35:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:35:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8169b9608d23a78c1cb34717fb6faa0f56ce36d1e6f1bab3870e332794f9db428ec1bf9a0cd142c79e27c95c3c3d4106bca21cf8856c9832da56ed1bfcfb41be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b200b3b408f3cad62915f7b42bf4568777258f6de16380bd87475815fb6624cbb94862eb4bb4115bfd265e91974f1a35f2ea04f8d342679c20ef9cd64be0009"} 17:35:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:35:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:35:16 INFO - Contents: 17:35:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8169b9608d23a78c1cb34717fb6faa0f56ce36d1e6f1bab3870e332794f9db428ec1bf9a0cd142c79e27c95c3c3d4106bca21cf8856c9832da56ed1bfcfb41be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b200b3b408f3cad62915f7b42bf4568777258f6de16380bd87475815fb6624cbb94862eb4bb4115bfd265e91974f1a35f2ea04f8d342679c20ef9cd64be0009"} 17:35:16 INFO - Running post-run listener: copy_logs_to_upload_dir 17:35:16 INFO - Copying logs to upload dir... 17:35:16 INFO - mkdir: /builds/slave/test/build/upload/logs 17:35:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.467270 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-24 17:35:16.434493) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 17:35:16.438470) ========= 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=32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8169b9608d23a78c1cb34717fb6faa0f56ce36d1e6f1bab3870e332794f9db428ec1bf9a0cd142c79e27c95c3c3d4106bca21cf8856c9832da56ed1bfcfb41be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b200b3b408f3cad62915f7b42bf4568777258f6de16380bd87475815fb6624cbb94862eb4bb4115bfd265e91974f1a35f2ea04f8d342679c20ef9cd64be0009"} build_url:https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/CjzQR2_6SFirAYYwUtYJsg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8169b9608d23a78c1cb34717fb6faa0f56ce36d1e6f1bab3870e332794f9db428ec1bf9a0cd142c79e27c95c3c3d4106bca21cf8856c9832da56ed1bfcfb41be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7b200b3b408f3cad62915f7b42bf4568777258f6de16380bd87475815fb6624cbb94862eb4bb4115bfd265e91974f1a35f2ea04f8d342679c20ef9cd64be0009"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 17:35:16.464917) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 17:35:16.465629) ========= 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=32c5991c409366f7fec8a718000001d2-1461541362.465012-974353910 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 17:35:16.549287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 17:35:16.550044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 17:35:16.550721) ========= ========= Total master_lag: 0.20 =========