builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1452381204.53 results: success (0) buildid: 20160109143755 builduid: 2af8f495022a44cdac44c4a0d52e66b8 revision: c06ff2c95163d8c4eabdf80643b08b93c1b16718 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.530587) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.531352) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.531753) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006212 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.557557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.557889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.572437) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.572866) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.622457) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.622793) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.623185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.623491) ========= 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=1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 15:13:25-- 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% 21.4M=0.001s 2016-01-09 15:13:25 (21.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176019 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.812333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.812664) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018066 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:24.863608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-01-09 15:13:24.864034) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c06ff2c95163d8c4eabdf80643b08b93c1b16718 --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 c06ff2c95163d8c4eabdf80643b08b93c1b16718 --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=1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 15:13:25,405 truncating revision to first 12 chars 2016-01-09 15:13:25,405 Setting DEBUG logging. 2016-01-09 15:13:25,405 attempt 1/10 2016-01-09 15:13:25,405 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c06ff2c95163?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 15:13:25,844 unpacking tar archive at: fx-team-c06ff2c95163/testing/mozharness/ program finished with exit code 0 elapsedTime=0.749386 ========= master_lag: 1.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-01-09 15:13:27.362257) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:27.362562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:27.411868) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:27.412232) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 15:13:27.416731) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-09 15:13:27.417093) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:13:28 INFO - MultiFileLogger online at 20160109 15:13:28 in /builds/slave/test 15:13:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 15:13:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:13:28 INFO - {'append_to_log': False, 15:13:28 INFO - 'base_work_dir': '/builds/slave/test', 15:13:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:13:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:13:28 INFO - 'branch': 'Fx-Team-Non-PGO', 15:13:28 INFO - 'buildbot_json_path': 'buildprops.json', 15:13:28 INFO - 'config_files': ('talos/linux_config.py',), 15:13:28 INFO - 'default_actions': ('clobber', 15:13:28 INFO - 'read-buildbot-config', 15:13:28 INFO - 'download-and-extract', 15:13:28 INFO - 'populate-webroot', 15:13:28 INFO - 'create-virtualenv', 15:13:28 INFO - 'install', 15:13:28 INFO - 'run-tests'), 15:13:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:13:28 INFO - 'download_minidump_stackwalk': True, 15:13:28 INFO - 'download_symbols': 'ondemand', 15:13:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:13:28 INFO - 'tooltool.py': '/tools/tooltool.py', 15:13:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:13:28 INFO - '/tools/misc-python/virtualenv.py')}, 15:13:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:13:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:13:28 INFO - 'installer_path': 'installer.exe', 15:13:28 INFO - 'log_level': 'info', 15:13:28 INFO - 'log_name': 'talos', 15:13:28 INFO - 'log_to_console': True, 15:13:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:13:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:13:28 INFO - 'opt_config_files': (), 15:13:28 INFO - 'pip_index': False, 15:13:28 INFO - 'sps_profile': False, 15:13:28 INFO - 'sps_profile_interval': 0, 15:13:28 INFO - 'suite': 'dromaeojs-e10s', 15:13:28 INFO - 'system_bits': '32', 15:13:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:13:28 INFO - 'title': 'talos-linux64-ix-027', 15:13:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:13:28 INFO - 'use_talos_json': True, 15:13:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:13:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:13:28 INFO - 'work_dir': 'build'} 15:13:28 INFO - ##### 15:13:28 INFO - ##### Running clobber step. 15:13:28 INFO - ##### 15:13:28 INFO - Running pre-action listener: _resource_record_pre_action 15:13:28 INFO - Running main action method: clobber 15:13:28 INFO - rmtree: /builds/slave/test/build 15:13:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:13:28 INFO - Running post-action listener: _resource_record_post_action 15:13:28 INFO - ##### 15:13:28 INFO - ##### Running read-buildbot-config step. 15:13:28 INFO - ##### 15:13:28 INFO - Running pre-action listener: _resource_record_pre_action 15:13:28 INFO - Running main action method: read_buildbot_config 15:13:28 INFO - Using buildbot properties: 15:13:28 INFO - { 15:13:28 INFO - "project": "", 15:13:28 INFO - "product": "firefox", 15:13:28 INFO - "script_repo_revision": "production", 15:13:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:13:28 INFO - "repository": "", 15:13:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:13:28 INFO - "buildid": "20160109143755", 15:13:28 INFO - "pgo_build": "False", 15:13:28 INFO - "basedir": "/builds/slave/test", 15:13:28 INFO - "buildnumber": 937, 15:13:28 INFO - "slavename": "talos-linux64-ix-027", 15:13:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:13:28 INFO - "platform": "ubuntu64_hw", 15:13:28 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:13:28 INFO - "branch": "fx-team", 15:13:28 INFO - "repo_path": "integration/fx-team", 15:13:28 INFO - "revision": "c06ff2c95163d8c4eabdf80643b08b93c1b16718", 15:13:28 INFO - "stage_platform": "linux64", 15:13:28 INFO - "builduid": "2af8f495022a44cdac44c4a0d52e66b8", 15:13:28 INFO - "slavebuilddir": "test" 15:13:28 INFO - } 15:13:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:13:28 INFO - Running post-action listener: _resource_record_post_action 15:13:28 INFO - ##### 15:13:28 INFO - ##### Running download-and-extract step. 15:13:28 INFO - ##### 15:13:28 INFO - Running pre-action listener: _resource_record_pre_action 15:13:28 INFO - Running main action method: download_and_extract 15:13:28 INFO - mkdir: /builds/slave/test/build/tests 15:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:28 INFO - https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:13:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/test_packages.json 15:13:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/test_packages.json 15:13:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:13:29 INFO - Downloaded 1302 bytes. 15:13:29 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:13:29 INFO - Using the following test package requirements: 15:13:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:13:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:13:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:29 INFO - u'jsshell-linux-x86_64.zip'], 15:13:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:13:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:13:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:13:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:13:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:13:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:13:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:13:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:13:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:13:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:29 INFO - https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:13:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:13:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:13:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:13:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:13:30 INFO - Downloaded 22761271 bytes. 15:13:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 15:13:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:13:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:13:31 INFO - Return code: 0 15:13:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:13:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:31 INFO - https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:13:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:13:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:13:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:13:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:13:32 INFO - Downloaded 22761271 bytes. 15:13:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 15:13:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:13:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:13:34 INFO - Return code: 0 15:13: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')]} 15:13:34 INFO - https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:13:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:13:35 INFO - Downloaded 11132285 bytes. 15:13:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 15:13:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:13:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:13:35 INFO - Return code: 0 15:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:35 INFO - https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:13:37 INFO - Downloaded 54052669 bytes. 15:13:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:13:37 INFO - mkdir: /builds/slave/test/properties 15:13:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:37 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:37 INFO - Contents: 15:13:37 INFO - build_url:https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:13:37 INFO - Running post-action listener: _resource_record_post_action 15:13:37 INFO - Running post-action listener: set_extra_try_arguments 15:13:37 INFO - ##### 15:13:37 INFO - ##### Running populate-webroot step. 15:13:37 INFO - ##### 15:13:37 INFO - Running pre-action listener: _resource_record_pre_action 15:13:37 INFO - Running main action method: populate_webroot 15:13:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:13:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:13:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:13:37 INFO - '--tppagecycles', 15:13:37 INFO - '7'], 15:13:37 INFO - 'tests': ['tsvgm']}}, 15:13:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:13:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:13:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:13:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:13:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:13:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:13:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:37 INFO - 'talos_options': ['--e10s'], 15:13:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:37 INFO - 'tests': ['damp', 'tps']}, 15:13:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:37 INFO - 'talos_options': ['--e10s'], 15:13:37 INFO - 'tests': ['damp', 'tps']}, 15:13:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:13:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:37 INFO - 'other': {'tests': ['a11yr', 15:13:37 INFO - 'ts_paint', 15:13:37 INFO - 'tpaint', 15:13:37 INFO - 'sessionrestore', 15:13:37 INFO - 'sessionrestore_no_auto_restore']}, 15:13:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:13:37 INFO - 'tests': ['a11yr', 15:13:37 INFO - 'ts_paint', 15:13:37 INFO - 'tpaint', 15:13:37 INFO - 'sessionrestore', 15:13:37 INFO - 'sessionrestore_no_auto_restore']}, 15:13:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:13:37 INFO - 'tests': ['a11yr', 15:13:37 INFO - 'ts_paint', 15:13:37 INFO - 'tpaint', 15:13:37 INFO - 'sessionrestore', 15:13:37 INFO - 'sessionrestore_no_auto_restore']}, 15:13:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:13:37 INFO - 'tests': ['a11yr', 15:13:37 INFO - 'ts_paint', 15:13:37 INFO - 'tpaint', 15:13:37 INFO - 'sessionrestore', 15:13:37 INFO - 'sessionrestore_no_auto_restore']}, 15:13:37 INFO - 'other_l64': {'tests': ['a11yr', 15:13:37 INFO - 'ts_paint', 15:13:37 INFO - 'tpaint', 15:13:37 INFO - 'sessionrestore', 15:13:37 INFO - 'sessionrestore_no_auto_restore']}, 15:13:37 INFO - 'other_nol64': {'tests': ['a11yr', 15:13:37 INFO - 'ts_paint', 15:13:37 INFO - 'tpaint', 15:13:37 INFO - 'sessionrestore', 15:13:37 INFO - 'sessionrestore_no_auto_restore']}, 15:13:37 INFO - 'svgr': {'tests': ['tsvgx', 15:13:37 INFO - 'tsvgr_opacity', 15:13:37 INFO - 'tart', 15:13:37 INFO - 'tscrollx', 15:13:37 INFO - 'cart']}, 15:13:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:13:37 INFO - 'tests': ['tsvgx', 15:13:37 INFO - 'tsvgr_opacity', 15:13:37 INFO - 'tart', 15:13:37 INFO - 'tscrollx', 15:13:37 INFO - 'cart']}, 15:13:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:37 INFO - 'tests': ['tp5o']}, 15:13:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:37 INFO - 'talos_options': ['--e10s'], 15:13:37 INFO - 'tests': ['tp5o']}, 15:13:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:37 INFO - 'talos_options': ['--xperf_path', 15:13:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:37 INFO - 'tests': ['tp5n']}, 15:13:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:37 INFO - 'talos_options': ['--e10s', 15:13:37 INFO - '--xperf_path', 15:13:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:37 INFO - 'tests': ['tp5n']}}, 15:13:37 INFO - 'talos.zip': {'path': '', 15:13:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:13:37 INFO - Running post-action listener: _resource_record_post_action 15:13:37 INFO - ##### 15:13:37 INFO - ##### Running create-virtualenv step. 15:13:37 INFO - ##### 15:13:37 INFO - Running pre-action listener: _resource_record_pre_action 15:13:37 INFO - Running main action method: create_virtualenv 15:13:37 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:13:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:37 INFO - Using real prefix '/usr' 15:13:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:37 INFO - Installing distribute.............................................................................................................................................................................................done. 15:13:39 INFO - Installing pip.................done. 15:13:39 INFO - Return code: 0 15:13:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f447dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, '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': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:13:39 INFO - Using env: {'DISPLAY': ':0', 15:13:39 INFO - 'HOME': '/home/cltbld', 15:13:39 INFO - 'LANG': 'en_US.UTF-8', 15:13:39 INFO - 'LANGUAGE': 'en_US:en', 15:13:39 INFO - 'LOGNAME': 'cltbld', 15:13:39 INFO - 'MAIL': '/var/mail/cltbld', 15:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:39 INFO - 'MOZ_NO_REMOTE': '1', 15:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:39 INFO - 'NO_EM_RESTART': '1', 15:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:39 INFO - 'PWD': '/builds/slave/test', 15:13:39 INFO - 'SHELL': '/bin/bash', 15:13:39 INFO - 'SHLVL': '1', 15:13:39 INFO - 'TERM': 'linux', 15:13:39 INFO - 'TMOUT': '86400', 15:13:39 INFO - 'USER': 'cltbld', 15:13:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:39 INFO - '_': '/tools/buildbot/bin/python'} 15:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:13:39 INFO - Cleaning up... 15:13:39 INFO - Return code: 0 15:13:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f447dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, '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': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 15:13:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:13:39 INFO - Using env: {'DISPLAY': ':0', 15:13:39 INFO - 'HOME': '/home/cltbld', 15:13:39 INFO - 'LANG': 'en_US.UTF-8', 15:13:39 INFO - 'LANGUAGE': 'en_US:en', 15:13:39 INFO - 'LOGNAME': 'cltbld', 15:13:39 INFO - 'MAIL': '/var/mail/cltbld', 15:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:39 INFO - 'MOZ_NO_REMOTE': '1', 15:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:39 INFO - 'NO_EM_RESTART': '1', 15:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:39 INFO - 'PWD': '/builds/slave/test', 15:13:39 INFO - 'SHELL': '/bin/bash', 15:13:39 INFO - 'SHLVL': '1', 15:13:39 INFO - 'TERM': 'linux', 15:13:39 INFO - 'TMOUT': '86400', 15:13:39 INFO - 'USER': 'cltbld', 15:13:39 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:39 INFO - '_': '/tools/buildbot/bin/python'} 15:13:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:40 INFO - Downloading/unpacking psutil>=0.7.1 15:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:13:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:13:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:13:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:42 INFO - Installing collected packages: psutil 15:13:42 INFO - Running setup.py install for psutil 15:13:42 INFO - building 'psutil._psutil_linux' extension 15:13:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:13:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:13:42 INFO - building 'psutil._psutil_posix' extension 15:13:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:13:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:13:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:42 INFO - Successfully installed psutil 15:13:42 INFO - Cleaning up... 15:13:42 INFO - Return code: 0 15:13:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f447dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, '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': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:13:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:13:42 INFO - Using env: {'DISPLAY': ':0', 15:13:42 INFO - 'HOME': '/home/cltbld', 15:13:42 INFO - 'LANG': 'en_US.UTF-8', 15:13:42 INFO - 'LANGUAGE': 'en_US:en', 15:13:42 INFO - 'LOGNAME': 'cltbld', 15:13:42 INFO - 'MAIL': '/var/mail/cltbld', 15:13:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:42 INFO - 'MOZ_NO_REMOTE': '1', 15:13:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:42 INFO - 'NO_EM_RESTART': '1', 15:13:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:42 INFO - 'PWD': '/builds/slave/test', 15:13:42 INFO - 'SHELL': '/bin/bash', 15:13:42 INFO - 'SHLVL': '1', 15:13:42 INFO - 'TERM': 'linux', 15:13:42 INFO - 'TMOUT': '86400', 15:13:42 INFO - 'USER': 'cltbld', 15:13:42 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:13:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:42 INFO - '_': '/tools/buildbot/bin/python'} 15:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:13:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:13:44 INFO - Installing collected packages: mozsystemmonitor 15:13:44 INFO - Running setup.py install for mozsystemmonitor 15:13:44 INFO - Successfully installed mozsystemmonitor 15:13:44 INFO - Cleaning up... 15:13:44 INFO - Return code: 0 15:13:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f447dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, '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': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:13:44 INFO - Using env: {'DISPLAY': ':0', 15:13:44 INFO - 'HOME': '/home/cltbld', 15:13:44 INFO - 'LANG': 'en_US.UTF-8', 15:13:44 INFO - 'LANGUAGE': 'en_US:en', 15:13:44 INFO - 'LOGNAME': 'cltbld', 15:13:44 INFO - 'MAIL': '/var/mail/cltbld', 15:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:44 INFO - 'MOZ_NO_REMOTE': '1', 15:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:44 INFO - 'NO_EM_RESTART': '1', 15:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:44 INFO - 'PWD': '/builds/slave/test', 15:13:44 INFO - 'SHELL': '/bin/bash', 15:13:44 INFO - 'SHLVL': '1', 15:13:44 INFO - 'TERM': 'linux', 15:13:44 INFO - 'TMOUT': '86400', 15:13:44 INFO - 'USER': 'cltbld', 15:13:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:44 INFO - '_': '/tools/buildbot/bin/python'} 15:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:44 INFO - Downloading/unpacking blobuploader==1.2.4 15:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:46 INFO - Downloading blobuploader-1.2.4.tar.gz 15:13:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:13:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:13:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:13:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:47 INFO - Downloading docopt-0.6.1.tar.gz 15:13:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:13:47 INFO - Installing collected packages: blobuploader, requests, docopt 15:13:47 INFO - Running setup.py install for blobuploader 15:13:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:13:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:13:47 INFO - Running setup.py install for requests 15:13:47 INFO - Running setup.py install for docopt 15:13:47 INFO - Successfully installed blobuploader requests docopt 15:13:47 INFO - Cleaning up... 15:13:47 INFO - Return code: 0 15:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f447dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, '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': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:13:47 INFO - Using env: {'DISPLAY': ':0', 15:13:47 INFO - 'HOME': '/home/cltbld', 15:13:47 INFO - 'LANG': 'en_US.UTF-8', 15:13:47 INFO - 'LANGUAGE': 'en_US:en', 15:13:47 INFO - 'LOGNAME': 'cltbld', 15:13:47 INFO - 'MAIL': '/var/mail/cltbld', 15:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:47 INFO - 'MOZ_NO_REMOTE': '1', 15:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:47 INFO - 'NO_EM_RESTART': '1', 15:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:47 INFO - 'PWD': '/builds/slave/test', 15:13:47 INFO - 'SHELL': '/bin/bash', 15:13:47 INFO - 'SHLVL': '1', 15:13:47 INFO - 'TERM': 'linux', 15:13:47 INFO - 'TMOUT': '86400', 15:13:47 INFO - 'USER': 'cltbld', 15:13:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:47 INFO - '_': '/tools/buildbot/bin/python'} 15:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:48 INFO - Running setup.py (path:/tmp/pip-YnufrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:48 INFO - Running setup.py (path:/tmp/pip-ONw3so-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:48 INFO - Running setup.py (path:/tmp/pip-NvfZyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:48 INFO - Running setup.py (path:/tmp/pip-VEYER6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:48 INFO - Running setup.py (path:/tmp/pip-uO919q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:48 INFO - Running setup.py (path:/tmp/pip-7ECLjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:48 INFO - Running setup.py (path:/tmp/pip-KEVB0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:48 INFO - Running setup.py (path:/tmp/pip-RfKbY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:48 INFO - Running setup.py (path:/tmp/pip-MSYQQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:48 INFO - Running setup.py (path:/tmp/pip-PtoPEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:48 INFO - Running setup.py (path:/tmp/pip-q_vnLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:48 INFO - Running setup.py (path:/tmp/pip-5nNq9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:48 INFO - Running setup.py (path:/tmp/pip-6UiwZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:48 INFO - Running setup.py (path:/tmp/pip-50zucs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:49 INFO - Running setup.py (path:/tmp/pip-z_wIsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:49 INFO - Running setup.py (path:/tmp/pip-yssFdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:49 INFO - Running setup.py (path:/tmp/pip-kPnNAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:13:49 INFO - Running setup.py install for manifestparser 15:13:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:13:49 INFO - Running setup.py install for mozcrash 15:13:49 INFO - Running setup.py install for mozdebug 15:13:49 INFO - Running setup.py install for mozdevice 15:13:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:13:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:13:49 INFO - Running setup.py install for mozfile 15:13:49 INFO - Running setup.py install for mozhttpd 15:13:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:13:49 INFO - Running setup.py install for mozinfo 15:13:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:13:49 INFO - Running setup.py install for mozInstall 15:13:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Running setup.py install for mozleak 15:13:50 INFO - Running setup.py install for mozlog 15:13:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Running setup.py install for moznetwork 15:13:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Running setup.py install for mozprocess 15:13:50 INFO - Running setup.py install for mozprofile 15:13:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Running setup.py install for mozrunner 15:13:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:13:50 INFO - Running setup.py install for mozscreenshot 15:13:50 INFO - Running setup.py install for moztest 15:13:50 INFO - Running setup.py install for mozversion 15:13:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:13:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:13:51 INFO - Cleaning up... 15:13:51 INFO - Return code: 0 15:13:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f447dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, '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': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:13:51 INFO - Using env: {'DISPLAY': ':0', 15:13:51 INFO - 'HOME': '/home/cltbld', 15:13:51 INFO - 'LANG': 'en_US.UTF-8', 15:13:51 INFO - 'LANGUAGE': 'en_US:en', 15:13:51 INFO - 'LOGNAME': 'cltbld', 15:13:51 INFO - 'MAIL': '/var/mail/cltbld', 15:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:51 INFO - 'MOZ_NO_REMOTE': '1', 15:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:51 INFO - 'NO_EM_RESTART': '1', 15:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:51 INFO - 'PWD': '/builds/slave/test', 15:13:51 INFO - 'SHELL': '/bin/bash', 15:13:51 INFO - 'SHLVL': '1', 15:13:51 INFO - 'TERM': 'linux', 15:13:51 INFO - 'TMOUT': '86400', 15:13:51 INFO - 'USER': 'cltbld', 15:13:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:51 INFO - '_': '/tools/buildbot/bin/python'} 15:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:51 INFO - Running setup.py (path:/tmp/pip-CjnGvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:51 INFO - Running setup.py (path:/tmp/pip-VUymA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:51 INFO - Running setup.py (path:/tmp/pip-ZbfL3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:51 INFO - Running setup.py (path:/tmp/pip-mn3AQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:51 INFO - Running setup.py (path:/tmp/pip-BUQV6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:51 INFO - Running setup.py (path:/tmp/pip-8f2TtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:51 INFO - Running setup.py (path:/tmp/pip-ARlRwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:51 INFO - Running setup.py (path:/tmp/pip-x222LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:51 INFO - Running setup.py (path:/tmp/pip-QTAa0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:51 INFO - Running setup.py (path:/tmp/pip-2ZmrOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:51 INFO - Running setup.py (path:/tmp/pip-aP2VXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:52 INFO - Running setup.py (path:/tmp/pip-mhOZ8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:52 INFO - Running setup.py (path:/tmp/pip-6HXhxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:52 INFO - Running setup.py (path:/tmp/pip-17z33g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:52 INFO - Running setup.py (path:/tmp/pip-F9JHf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:52 INFO - Running setup.py (path:/tmp/pip-AEokJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:13:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:52 INFO - Running setup.py (path:/tmp/pip-IoMCAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:13:52 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:13:52 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:13:52 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:13:52 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:13:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:54 INFO - Downloading blessings-1.5.1.tar.gz 15:13:54 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:13:54 INFO - Installing collected packages: blessings 15:13:54 INFO - Running setup.py install for blessings 15:13:54 INFO - Successfully installed blessings 15:13:54 INFO - Cleaning up... 15:13:54 INFO - Return code: 0 15:13:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:13:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:54 INFO - Reading from file tmpfile_stdout 15:13:54 INFO - Current package versions: 15:13:54 INFO - argparse == 1.2.1 15:13:54 INFO - blessings == 1.5.1 15:13:54 INFO - blobuploader == 1.2.4 15:13:54 INFO - docopt == 0.6.1 15:13:54 INFO - manifestparser == 1.1 15:13:54 INFO - mozInstall == 1.12 15:13:54 INFO - mozcrash == 0.16 15:13:54 INFO - mozdebug == 0.1 15:13:54 INFO - mozdevice == 0.47 15:13:54 INFO - mozfile == 1.2 15:13:54 INFO - mozhttpd == 0.7 15:13:54 INFO - mozinfo == 0.9 15:13:54 INFO - mozleak == 0.1 15:13:54 INFO - mozlog == 3.1 15:13:54 INFO - moznetwork == 0.27 15:13:54 INFO - mozprocess == 0.22 15:13:54 INFO - mozprofile == 0.28 15:13:54 INFO - mozrunner == 6.11 15:13:54 INFO - mozscreenshot == 0.1 15:13:54 INFO - mozsystemmonitor == 0.0 15:13:54 INFO - moztest == 0.7 15:13:54 INFO - mozversion == 1.4 15:13:54 INFO - psutil == 3.1.1 15:13:54 INFO - requests == 1.2.3 15:13:54 INFO - wsgiref == 0.1.2 15:13:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f447dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, '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': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:13:54 INFO - Using env: {'DISPLAY': ':0', 15:13:54 INFO - 'HOME': '/home/cltbld', 15:13:54 INFO - 'LANG': 'en_US.UTF-8', 15:13:54 INFO - 'LANGUAGE': 'en_US:en', 15:13:54 INFO - 'LOGNAME': 'cltbld', 15:13:54 INFO - 'MAIL': '/var/mail/cltbld', 15:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:54 INFO - 'MOZ_NO_REMOTE': '1', 15:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:54 INFO - 'NO_EM_RESTART': '1', 15:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:54 INFO - 'PWD': '/builds/slave/test', 15:13:54 INFO - 'SHELL': '/bin/bash', 15:13:54 INFO - 'SHLVL': '1', 15:13:54 INFO - 'TERM': 'linux', 15:13:54 INFO - 'TMOUT': '86400', 15:13:54 INFO - 'USER': 'cltbld', 15:13:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:54 INFO - '_': '/tools/buildbot/bin/python'} 15:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:13:54 INFO - Cleaning up... 15:13:54 INFO - Return code: 0 15:13:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f447dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, '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': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:13:54 INFO - Using env: {'DISPLAY': ':0', 15:13:54 INFO - 'HOME': '/home/cltbld', 15:13:54 INFO - 'LANG': 'en_US.UTF-8', 15:13:54 INFO - 'LANGUAGE': 'en_US:en', 15:13:54 INFO - 'LOGNAME': 'cltbld', 15:13:54 INFO - 'MAIL': '/var/mail/cltbld', 15:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:54 INFO - 'MOZ_NO_REMOTE': '1', 15:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:54 INFO - 'NO_EM_RESTART': '1', 15:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:54 INFO - 'PWD': '/builds/slave/test', 15:13:54 INFO - 'SHELL': '/bin/bash', 15:13:54 INFO - 'SHLVL': '1', 15:13:54 INFO - 'TERM': 'linux', 15:13:54 INFO - 'TMOUT': '86400', 15:13:54 INFO - 'USER': 'cltbld', 15:13:54 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:54 INFO - '_': '/tools/buildbot/bin/python'} 15:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:55 INFO - Downloading/unpacking jsonschema 15:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:13:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 15:13:56 INFO - Downloading/unpacking functools32 (from jsonschema) 15:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:57 INFO - Downloading functools32-3.2.3-2.tar.gz 15:13:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:13:57 INFO - warning: no files found matching '*.txt' 15:13:57 INFO - no previously-included directories found matching 'build' 15:13:57 INFO - no previously-included directories found matching 'dist' 15:13:57 INFO - no previously-included directories found matching '.git*' 15:13:57 INFO - Installing collected packages: jsonschema, functools32 15:13:57 INFO - Running setup.py install for functools32 15:13:57 INFO - warning: no files found matching '*.txt' 15:13:57 INFO - no previously-included directories found matching 'build' 15:13:57 INFO - no previously-included directories found matching 'dist' 15:13:57 INFO - no previously-included directories found matching '.git*' 15:13:57 INFO - Successfully installed jsonschema functools32 15:13:57 INFO - Cleaning up... 15:13:57 INFO - Return code: 0 15:13:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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')]} 15:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f447dcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x168cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, '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': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:13:57 INFO - Using env: {'DISPLAY': ':0', 15:13:57 INFO - 'HOME': '/home/cltbld', 15:13:57 INFO - 'LANG': 'en_US.UTF-8', 15:13:57 INFO - 'LANGUAGE': 'en_US:en', 15:13:57 INFO - 'LOGNAME': 'cltbld', 15:13:57 INFO - 'MAIL': '/var/mail/cltbld', 15:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:57 INFO - 'MOZ_NO_REMOTE': '1', 15:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:57 INFO - 'NO_EM_RESTART': '1', 15:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:57 INFO - 'PWD': '/builds/slave/test', 15:13:57 INFO - 'SHELL': '/bin/bash', 15:13:57 INFO - 'SHLVL': '1', 15:13:57 INFO - 'TERM': 'linux', 15:13:57 INFO - 'TMOUT': '86400', 15:13:57 INFO - 'USER': 'cltbld', 15:13:57 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:57 INFO - '_': '/tools/buildbot/bin/python'} 15:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:57 INFO - Downloading/unpacking flake8 15:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:13:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 15:13:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:13:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 15:13:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 15:13:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:13:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:13:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:13:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:13:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:13:59 INFO - no previously-included directories found matching 'docs/_build' 15:13:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:13:59 INFO - Running setup.py install for pep8 15:14:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:14:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:14:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:14:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:14:00 INFO - no previously-included directories found matching 'docs/_build' 15:14:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:14:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:14:00 INFO - Cleaning up... 15:14:00 INFO - Return code: 0 15:14:00 INFO - Running post-action listener: _resource_record_post_action 15:14:00 INFO - Running post-action listener: _start_resource_monitoring 15:14:00 INFO - Starting resource monitoring. 15:14:00 INFO - ##### 15:14:00 INFO - ##### Running install step. 15:14:00 INFO - ##### 15:14:00 INFO - Running pre-action listener: _resource_record_pre_action 15:14:00 INFO - Running main action method: install 15:14:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:00 INFO - Reading from file tmpfile_stdout 15:14:00 INFO - Detecting whether we're running mozinstall >=1.0... 15:14:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:14:00 INFO - Reading from file tmpfile_stdout 15:14:00 INFO - Output received: 15:14:00 INFO - Usage: mozinstall [options] installer 15:14:00 INFO - Options: 15:14:00 INFO - -h, --help show this help message and exit 15:14:00 INFO - -d DEST, --destination=DEST 15:14:00 INFO - Directory to install application into. [default: 15:14:00 INFO - "/builds/slave/test"] 15:14:00 INFO - --app=APP Application being installed. [default: firefox] 15:14:00 INFO - mkdir: /builds/slave/test/build/application 15:14:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:14:16 INFO - Reading from file tmpfile_stdout 15:14:16 INFO - Output received: 15:14:16 INFO - /builds/slave/test/build/application/firefox/firefox 15:14:16 INFO - Running post-action listener: _resource_record_post_action 15:14:16 INFO - ##### 15:14:16 INFO - ##### Running run-tests step. 15:14:16 INFO - ##### 15:14:16 INFO - Running pre-action listener: _resource_record_pre_action 15:14:16 INFO - Running main action method: run_tests 15:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:14:16 INFO - Python 2.7.3 15:14:16 INFO - Return code: 0 15:14:16 INFO - grabbing minidump binary from tooltool 15:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:16 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 0x171f3d0>, '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 0x168aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x168b360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:14:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:14:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:14:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:14:16 INFO - Return code: 0 15:14:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:14:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:14:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:14:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:14:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:14:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:14:17 INFO - Return code: 0 15:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:14:17 INFO - Using env: {'DISPLAY': ':0', 15:14:17 INFO - 'HOME': '/home/cltbld', 15:14:17 INFO - 'LANG': 'en_US.UTF-8', 15:14:17 INFO - 'LANGUAGE': 'en_US:en', 15:14:17 INFO - 'LOGNAME': 'cltbld', 15:14:17 INFO - 'MAIL': '/var/mail/cltbld', 15:14:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:14:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:17 INFO - 'MOZ_NO_REMOTE': '1', 15:14:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:17 INFO - 'NO_EM_RESTART': '1', 15:14:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:17 INFO - 'PWD': '/builds/slave/test', 15:14:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:14:17 INFO - 'SHELL': '/bin/bash', 15:14:17 INFO - 'SHLVL': '1', 15:14:17 INFO - 'TERM': 'linux', 15:14:17 INFO - 'TMOUT': '86400', 15:14:17 INFO - 'USER': 'cltbld', 15:14:17 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555', 15:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:17 INFO - '_': '/tools/buildbot/bin/python'} 15:14:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:14:17 INFO - mozversion application_buildid: 20160109143755 15:14:17 INFO - mozversion application_changeset: c06ff2c95163d8c4eabdf80643b08b93c1b16718 15:14:17 INFO - mozversion application_display_name: Nightly 15:14:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:14:17 INFO - mozversion application_name: Firefox 15:14:17 INFO - mozversion application_remotingname: firefox 15:14:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:14:17 INFO - mozversion application_vendor: Mozilla 15:14:17 INFO - mozversion application_version: 46.0a1 15:14:17 INFO - mozversion platform_buildid: 20160109143755 15:14:17 INFO - mozversion platform_changeset: c06ff2c95163d8c4eabdf80643b08b93c1b16718 15:14:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:14:17 INFO - mozversion platform_version: 46.0a1 15:14:17 INFO - using testdate: 1452381257 15:14:17 INFO - actual date: 1452381257 15:14:17 INFO - starting webserver on 'localhost:57271' 15:14:17 INFO - SUITE-START | Running 3 tests 15:14:17 INFO - TEST-START | dromaeo_css 15:14:17 INFO - operating with platform_type : linux_ 15:14:17 INFO - Initialising browser for dromaeo_css test... 15:14:17 INFO - TEST-INFO | started process 27079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxbczyg/profile http://localhost:57271/getInfo.html) 15:14:20 INFO - PROCESS | 27079 | 15:14:20 INFO - PROCESS | 27079 | (process:27160): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:14:21 INFO - PROCESS | 27079 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:14:21 INFO - PROCESS | 27079 | __metrics Screen width/height:1600/1200 15:14:21 INFO - PROCESS | 27079 | colorDepth:24 15:14:21 INFO - PROCESS | 27079 | Browser inner width/height: 1024/697 15:14:21 INFO - PROCESS | 27079 | __metrics 15:14:21 INFO - PROCESS | 27079 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:14:22 INFO - TEST-INFO | 27079: exit 0 15:14:22 INFO - Browser initialized. 15:14:22 INFO - Running cycle 1/1 for dromaeo_css test... 15:14:22 INFO - TEST-INFO | started process 27209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxbczyg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:24 INFO - PROCESS | 27209 | 15:14:24 INFO - PROCESS | 27209 | (process:27265): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:14:34 INFO - PROCESS | 27209 | RSS: Main: 150417408 15:14:34 INFO - PROCESS | 27209 | 15:15:24 INFO - PROCESS | 27209 | 1452381324433 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:17:36 INFO - PROCESS | 27209 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57271/tests/dromaeo/cssquery-ext.html) 15:17:37 INFO - PROCESS | 27209 | RSS: Main: 153600000 15:17:37 INFO - PROCESS | 27209 | 15:20:39 INFO - PROCESS | 27209 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-ext.html (next: http://localhost:57271/tests/dromaeo/cssquery-jquery.html) 15:20:39 INFO - PROCESS | 27209 | RSS: Main: 153477120 15:20:39 INFO - PROCESS | 27209 | 15:23:41 INFO - PROCESS | 27209 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57271/tests/dromaeo/cssquery-mootools.html) 15:23:42 INFO - PROCESS | 27209 | RSS: Main: 154271744 15:23:42 INFO - PROCESS | 27209 | 15:26:44 INFO - PROCESS | 27209 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57271/tests/dromaeo/cssquery-prototype.html) 15:26:44 INFO - PROCESS | 27209 | RSS: Main: 152809472 15:26:44 INFO - PROCESS | 27209 | 15:29:47 INFO - PROCESS | 27209 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57271/tests/dromaeo/cssquery-yui.html) 15:29:47 INFO - PROCESS | 27209 | RSS: Main: 153845760 15:29:47 INFO - PROCESS | 27209 | 15:32:50 INFO - PROCESS | 27209 | Cycle 1(1): loaded http://localhost:57271/tests/dromaeo/cssquery-yui.html (next: http://localhost:57271/tests/dromaeo/cssquery-dojo.html) 15:32:50 INFO - PROCESS | 27209 | RSS: Main: 156237824 15:32:50 INFO - PROCESS | 27209 | 15:32:50 INFO - PROCESS | 27209 | __start_tp_report 15:32:50 INFO - PROCESS | 27209 | _x_x_mozilla_page_load 15:32:50 INFO - PROCESS | 27209 | _x_x_mozilla_page_load_details 15:32:50 INFO - PROCESS | 27209 | |i|pagename|runs| 15:32:50 INFO - PROCESS | 27209 | |0;dojo.html;2622.5934980078086;2690.59641053842;2722.3874628208655;2735.8221715588493;2736.1654695317934;4474.709143905644;4562.680612357136;4579.977100114499;4605.286180642006;4660.813567457302;4545.204589196894;4576.130535198318;4653.115907977482;4654.464736555297;4688.906221875561;4059.7361171523758;4294.098239369736;4296.656267498593;4350.0429905420915;4367.192069467143;4146.3780432935155;4302.65578753699;4318.8488402905905;4358.171947330013;4388.714733542325;4217.34631132175;4226.619604235633;4288.656907447428;4302.462192225972;4316.892077698051;4294.484661840568;4297.78511074445;4298.484181898161;4300.763458009808;4351.369051487548;4073;4180.017695841475;4270.871873843758;4280.351561136833;4330.826766929319;4456.598906098434;4480.663950203748;4497.64018878489;4635.351050852883;4685.484596694361;4898.142825005645;4948.158813001798;4983.352164218664;4998.975005124988;5031.924521132186;4865.829695960624;5023.572996295319;5025.497450254982;5035.118854200537;5073.036123136592;4570.063137056929;4617.653675974316;4661.487236403993;4663.253879379283;4719.59883409914;5111.693298402033;5119.820806271762;5140.126178549655;5141.38303403594;5186.533212010937;4746.5490778376;4848.442429120626;4935.087008903364;4960.603151747851;4996.475370086161;4935.3090567320605;4980.228064649985;4983.725895075733;5004.3994720633755;5049;4901.730404827768;4938.975305123451;4950.18321976877;4965.329680493087;4996.550310472075;4733.881652958704;4863.781129849165;4896.926546101811;4928.975355123202;4951.405831300267;4124.649404800625;4129.215449064728;4131.400946862688;4145.585441455831;4165.10450253191;3645.9635403646153;3659.780413175218;3664;3670.064133645903;3687.465317528997;4148.149629325981;4265.55211702773;4279.101388708406;4308.806103725277;4334.739915605074;4972.602191824645;4988.476209997971;5006.07387633289;5020.698758074527;5053.823116190989;4292.463442069741;4308.80610372534;4317.158154159909;4318.244307246219;4351.19502891966;4267.786610669516;4368.60682538573;4392.3191905254735;4418.315161150027;4455.175792478337;4781.306710526954;4808.134535783593;4810.7113573185725;4815.277708343637;4832.49258827818;4800.207965685623;5024.447310795883;5026.824061157842;5056.7724452399;5113.463086375877;4669.066186762593;4679.578837904605;4720.150372932768;4738.715677059387;4772.379590653193;4889.217725163957;4905.730184839868;4925.778339974638;4960.255961605788;4981.053599816023;4851.078295123915;4987.376577927759;5013.423456302572;5019.0463811875625;5073.797048118034;4797.376341075638;4850.878728031827;4852.75736213195;4858.17411040117;4904.975475122602;4867.634927380532;4877.317175595491;4878.56092951636;4880.95119048805;4909.214525675875;4617.445906491243;4697.248440249544;4746.406699162605;4789.784459699392;4835.153848076643;4879.829205977774;4898.657094003385;4929;4934.827281045146;4937.703737775745;4825.131476334293;4838.782254798472;4838.975805120952;4860.027994401064;4886.096072226649 15:32:50 INFO - PROCESS | 27209 | |1;ext.html;475.969062010969;479.57317986991586;488.9315495830584;493.27734868417804;510.3544016818724;25103.74896251039;32988.515516801745;33092.99999999997;33317.83341083297;33394.833025834836;35703;36278.45582316267;36305.81847090761;36353.0911727207;36377.090572735695;7599.848003039922;7788.649510772028;7789.454738168331;7796.649150788228;7797.103333116679;7398.926010739904;7535.849283014364;7536.510126841765;7558.848823023536;7566.054243219598;7484.476086673935;7598.8480230395635;7600.809979750523;7617.961910190441;7618.771436856876;7415.555066696015;7510.211427800057;7537.095548534184;7542.491501699682;7552.093748750158;7402.481826272109;7560.848783024308;7563.432742544332;7587.051618547682;7765.961170194113;36258.274834503165;36344.091397715005;36677.083072923124;36875.446868297;36917.63082369169;2865.899693510717;2947.7052294770565;2959.8668059937354;3014.4724673182322;3625.148090198801;27717.58423623647;27892;28137.452440115787;28227.435451290858;28345.716542834514;3253.1216571525556;3254.2189874429964;3267.313864088544;3275.3613045456145;3308.983455082709;206826;209272;209501;210122;210705;45817.08365832665;47298.29052564214;52415.73792131091;53006.204906926425;53429.465705343224;47614.76192619015;47889;47945.28082078772;48014.27978580324;48054;14086.43654253839;14288;14297.356618952172;14303.856961430462;14306.785398219035;11139.498722557504;11187.776244475064;11222.775544489064;11282.887171128348;11291.435428228555;17687.557811054827;18054.90972545129;18117.909410452863;18308.267669293346;18343.54141146482;7424.294692004251;7512.436567257478;7606.353459955855;7613.276738709814;7692.076950765944;772.25863171355;854.4446110028407;869.6956065377068;873.8208667223204;970.4322971062007;26052.478950420886;26187.607185892226;26462.33844153873;28435;28897.133086007034;914.8518609145613;948.2698322291797;964.3490643815396;996.4519514267124;1073.2058276875057;12720.363981801058;12997.545085921947;13073.411696473682;13116.606501804961;13147.14543554666;255698;259034;259093;260135;260839;44019;44287;44395.556044439785;44466.555334446886;44706;1220.7619514194823;1228.444834743731;1246.8005119180887;1252.5803855708439;1253.022642338977;24226.51546969086;25006.62490062687;25197;25253.11614093498;25563.36091597725;38746;38797.2240555193;38950.220995579366;39021.2195756089;39212.41181382338;201383;202824;203816;204014;204270;27209.319767005192;27933.301667458476;28609.42781144407;28755;28763;33556.496652549744;33916;34091.65908340885;34162.14594635154;34176.82911585525;30828;30882;31238.375232495677;31826.522602160523;32184.83907580447;31425.8428707855;31877.681223187472;32066.679333206368;33371.49942750812;33532.49701254434;29906.551401729426;29975.850120749255;29982.700172998862;30225.546616801206;30400.695993039786;26275.343116422242;26789.732102678725;27064.1880743578;27334.5899811499;27542.449151016466;21687.45781355479;21837.344879653636;21862.23482178116;21932.671009934544;22221 15:32:50 INFO - PROCESS | 27209 | |2;jquery.html;315.81840441746004;317.69659974724135;318.60970311368567;329.0736576537048;336.7524869221122;14275.214863182533;14893.180875051868;15002.249887505608;15069.698606027887;15790;14270.643233919158;14307.928460357683;15185.240737963113;15189.392424303041;15215.39138434464;4340.218760623079;4716.174669432836;4895.437024742165;4918.0901533216465;4923.876903077416;4820.204666230068;4849.102915960541;4882.584980276681;5663.0655941769555;5682.914756278638;3433.896983090511;3578.516900218476;4921.507849215086;5632.915506267409;5641.8589535261535;5086.618503612225;5087.931534377785;5107.387113546398;5128.435872054071;5142.3829140503;4808.110499557593;5042.974785126087;5065.544101030925;5084.059449001909;5091.8981620367385;10882.347059176474;11217.04655104309;11308.886911130865;11345.546178152865;11385.259958102697;1689.1891891891837;1702.446704820938;1713.323237321251;1801.2704854533936;1861.1252711225702;8395.916040839575;8444.493330400195;8528.829423411558;8553.48679079251;8776.122387761237;1711.5977745229861;1735.1150913034444;1745.7206846904562;1779.421687951408;1862.748528948588;42135.36796948048;43635.563644363465;45231;49238.75380623074;52658.21012684813;9762.426335198024;9802.509874506246;9806.65676701312;9808.558614862348;9925;12347.13570050088;12385.442655080544;12412.937935310265;12414.131010829155;12471.127021108618;6968.198657154391;7037.753678621224;7040.225575186725;7069.71721131149;7122.109736282965;6644.069830223772;6674.06563081169;6680.532362734659;6682.599044057372;6684.699188536528;4089.7137200395687;4191.455110835572;4201.306784380604;4201.306784380604;4220.915581688349;1708.709519381708;1746.6244757377224;1759.2962814873897;1769.4517297364805;1793.0765655687333;363.88355726167373;366.8349242840732;392.2625464127422;395.2904536357246;830.7424698343533;8921.063288354759;9008.954955225181;9047.457152570867;9346.953265233631;9701.126898579161;395.1129713792554;814.8207394373228;882.668999125328;886.7206829848577;952.8427809411509;8110.594470276463;8215.260626543639;8251.257386835214;8284.668613255522;8404.033536143423;449451;467720;496060.5196973992;503738;503812;61480;63030.36969630245;63197.052044219374;63330.0500492493;64017;1064.6486659402378;1078.8166011778017;1082.0423924826584;1091.792559413709;1091.9617813376335;12748.745025099632;12757.362131893553;12956.740865182455;12965.22208667483;13123.803142953055;27157.321066973484;27357;27415;27598;27609.585856212576;37276.62723372732;37573.43639845459;37778.244435110595;38003.80998094992;38416;6603.702833372606;6730.226024007106;6739.05653208561;6791.830204244933;7021.297870212938;8954.417962832395;9891.950540247253;10016.64941727036;10401.479926003518;10426.322289051188;7630.389568834591;7742.341900938483;8492.872606911025;8586.871196932176;8677.696280630147;8528.317734581095;8886.24466920319;8975.865362019706;9252.352335336462;9313.813723725623;7832.765017049498;8598.183172598594;8714.477131372138;8716.302695784196;8732.825343493221;6280.340564240689;6519.380658837403;6576.309487503743;6584.04531342943;6587.2753997061245;8165.79585510367;8908.777280568038;9110.544472776468;9199.35604507678;9215.723528294162 15:32:50 INFO - PROCESS | 27209 | |3;mootools.html;1378.124890694409;1390.3951780975276;1490.9925450372746;1701.9489415317544;1715.6568686262742;6224.84437889053;6364.490840732742;7271.236520165379;7426.145993210783;7468.365188958938;7061.293870612949;7245.166805817333;7273.745418910339;7279.126504819429;7291.635418229094;2116.1958455786817;2144.742630884296;2146.431195733132;2146.8175205107586;2152.9031193596325;2086.3428020173674;2122.3420739570784;2210.944726381845;2220.2562141682474;2224.343818573525;2159.0500179920864;2168.024389024937;2179.5967745967046;2198.2196320306302;2204.867707937529;2176.6082105221053;2178.302943058222;2179.259051922346;2183.4868805830615;2185.4317877352005;2151.9462013449634;2167.631502644554;2175.9238426654993;2180.5856887191385;2189.562087582474;7365.337119659256;7404.074490688664;7432.665530051161;7445.367143792784;7469.253074692541;4371.562843715635;4495.325701144821;4499.775011249424;4506.5493450655;4506.819727210907;2860.699626539225;2898.507253766865;2911.141213342069;2921.0506585359844;2971.7028297170327;903.1826197291396;936.6440752514001;946.9621215151386;950.1733491862055;956.8803899512561;10385.532651030646;10453.37279763209;10480.94759526205;10488.108510776594;10492.842607360895;4061.5329237138108;4098.4876890388705;4139.710220284612;4143.70994030421;4195.832166713297;8785.69250076257;8809.515476648847;8844.55777211137;8846.513441760637;8854.557272136368;4511.526289739596;4518.661100417482;4519.480259770103;4529.365888775574;4531.116432295737;3340.5323254744353;3426.9828650856584;3815.5802861685747;4017.83928642851;4043.272211001989;3566.1797786509246;3581.83881725323;3590.030691713223;3622.8550857965915;3631.5460567429072;1156.6414411532285;1188.4948896719034;1191.065013964034;1192.7733730591333;1196;793.7698067560343;890.2966656341547;1160.512584714422;1162.610525473959;1175.647305808254;6767.323267673291;6770.052192693027;6828.146481689789;6829.453643708591;6835.521513494008;1027.8817935937313;1061.7292590389402;1062.8724553053528;1072.4423299884018;1093.0435868614961;5411.729413529308;5475.479829416199;5483.7806487740045;5500.559955203574;5505.311836020497;8279.337652987746;8768.605412756442;8916.643334266557;8939.597718102701;8941.077668301215;8750.606222719865;8787.692430764893;8828.337874659297;8857.512836793909;8882.378233523592;6929.688164032631;6985.091938048021;6992.580445173306;7188.676509556978;7197.496175267681;6894.413974812197;6911;6932.237453879969;6943.861122777617;6978.511504194657;7996.640151193326;8261.463004904663;8288.58557072132;8327.125651806473;8368.24685778283;8208.507489550646;8390.790230244293;8488.363372746946;8522.829543409222;8584.098669639598;6160.722767475385;6263.937360626518;6299.433051025247;6522.21733391996;6533.18335208099;6748.797536073926;6752.5948443093575;6756.054152418567;6797.966010169917;6819.181698196248;6387.776427825004;6466.838329041811;6528.9020664689115;6584.572002819801;6631.104800851823;6283.3402492737605;6486.156799616208;6530.706118224596;6784.423324017514;6790.932090679227;6529.922562777088;6583.967080164569;6587.473002159912;6591.406773390418;6611.966940165268;6167.629942203482;6225.688715564294;6256.812295631138;6257.217847769029;6265.592736472115;6251.812445626639;6260.655663938527;6288.496920246278;6295.874082518416;6305.274893387135 15:32:50 INFO - PROCESS | 27209 | |4;prototype.html;307.0726406253116;311.1971114524527;312.6404634670129;314.7576366198026;315.2449882531337;5433.918491222635;5561.416051314614;5572.247746554214;5588.832335029945;5613.045782217023;5527.695976721288;5527.944720552793;5529.30883639545;5532.2531458253125;5548.91676624851;4124.855630052949;4256.063665993476;4303.35449682547;4304.526502084768;4308.547602501739;4243.511996120455;4255.255330317197;4274.935875961863;4278.828846846122;4281.165172791307;4205.2851015327315;4227.387028880826;4228.915421691564;4231.534531201565;4233.216854881842;4228.534861165269;4231.851885184004;4244.299690551055;4246.193223287596;4250.787460626987;3685.7788532688123;3706.42550404685;3708.6662200402093;3711.4989476420606;3713.740038197327;5151.742412879341;5316.308879845634;5328.706921119337;5372.462753724635;5377.435369286208;4890.633202509791;4896.192128298826;4903.313536104948;4904.0437114762635;4908.141075311806;5870.11948207768;5870.354261031283;5872.265966754156;5880;5881.647101173943;4031.23406552757;4034.616711412411;4038.6567141792984;4042.272390969624;4052.8176232069627;5884.411558844125;6082.422169893853;6122.14289999396;6126.479249263818;6150.384961503859;4102.651274641689;4133.627973482341;4134.421181034658;4142.171565686875;4150.8547200848425;4213.768242746617;4214.1150358425075;4214.473190851144;4218.472690913636;4219.472565929259;4819.855404337875;4828.37231159954;4833.613310935187;4841.8547443576745;4853.39332583427;5676.772929082873;5787.768489260467;5808.709564521757;5814.622049566765;5816.5928385013485;1475.4983305676121;1495.364470100203;1503.3084781000643;1504.0374160537265;1508.3287936868207;990.64336838738;995.3132338686283;998.236349192868;1012.6253286283975;1025.092792878308;5082.009008243357;5090.745462726849;5099.260607211933;5103.336566246438;5115.71863547501;5961.791337303173;6099.329073801879;6099.542534309856;6152;6159.876802463926;5088.1350170471105;5125.666831655931;5163.044836705221;5182.896342073137;5192.273081768555;3282.983585082107;3314.353701028276;3315.1712071982006;3320.1035720355367;3326.151831283007;5650.491455769001;5779.508741756914;5781.075027995501;5785.623934444247;5826.6795326256615;6277.24673039229;6297.27581328144;6299.905501417483;6308.116863639094;6328.651924144124;5759.107338362561;5791.276090488689;5796.449337312949;5796.739146738491;5815.982203114438;5991.670458124845;6138.508919286357;6151.9384806151365;6154.753809847556;6157.661328626789;5907.940920590739;5979.833932383143;5987.520998320037;5994.550408719277;5997;5772.6247793894945;5774.595778295479;5778.451047150514;5780.5953583248765;5798.10129429939;4151.584841515824;4182.581741825915;4190.099128687347;4195.748255104703;4195.790210489402;5886.970565147147;6088.908666370096;6122.326544080059;6126.509879209563;6138.232720909887;5852.648841069549;5882.823515294548;5899.793507227227;5914.881702365842;5917.053271476543;5897.67562784051;5905.852353691193;5908.734106965283;5908.763649453974;5921.585489015728;5695;5762.94237057624;5764.250647415809;5774.191613174243;5793.9420605795085;5910.70446477683;5927.733252003584;5941.197938278277;5947.464728174485;5957.6127551709;5497.8075767347955;5757.539396848326;5774.307083150049;5781.219535362672;5792.507636850914 15:32:50 INFO - PROCESS | 27209 | |5;yui.html;629.8897692903743;630.3444417805482;699.5724834823162;730.5032577847063;755.8488302339533;11002.449877506133;11111.166662500304;11167.944160279187;11201.60794372197;11213.215074944757;10769.730756731085;10781.137508999282;10809.621663241787;10820.296680715768;10852.294600850939;601.8555546668812;613.1630324606924;754.7735679296217;768.9692412303501;771.4329967473931;757.8787394016958;759.8062494064034;765.2347652347653;766.8888011238395;770.0797546931419;805.5287656720825;809.4900212865915;810.2181394953868;811.0713233347814;813.1015228172843;799.2007992007963;801.6472751989136;803.6263137641025;804.1355542791523;805.0781854776307;592.5970340168684;596.6122020686545;597.235538510707;597.3518732175595;598.8083813179784;11190.216684832065;11199.440027998568;11304.773904521864;11355.375454350007;11373.374464404455;11431.714207144805;11462.312261264267;11697.824532632018;11906.404679765978;12094.153409261355;9155.816883662355;9462.668806591737;9490.383125096847;9494.430334179902;9509.762255943588;3956.287868183726;4050.3721923101966;4052.4731784867777;4052.5136983561865;4142.647874930634;39686.20627587461;39864.60473883429;39959.40060899089;40183.79908100441;40285.79857100725;8602.18279263469;8693.739187824376;8708.651653933772;8733.432326898732;9066.365354425126;15290.311935962909;15362.078275303518;15383.307751151002;15432.305546250445;15469.922650386676;5734.139879018097;5768.826935191951;5806.332271788799;6006.339302676702;6284.3087260402235;3466;3476.2526056897887;3480.89557313281;3495.528103705967;3535.4520049392386;2620.868956552165;2653.787696984237;2659.348459627404;2659.7074321824584;2659.734026597325;470.89404883901534;473.8246848665947;474.35014030777364;476.6734786671141;477.59165913144454;509;551.8454832646865;572.090376301674;574.371063685264;574.5518495573459;7273.6726847292;7403.666834992438;7436.628168591657;7451.254874512505;7501.624918754041;621.2824188062795;630.8424041883196;631.4916492223712;634.9935352466392;637.5664548107331;3639.5632524097277;3652.196516766307;3668.192997540537;3682.1715114099115;3683.2817600567632;43901.341479877825;45123.774381127885;45328.77335613301;45751.313730293405;45817.312740308924;40508.18983620311;40737.18525629471;41021;41565.79217103895;43326.56673433288;36864.815675921986;37091;38589.80705096456;38735.031624209056;40013.79993100074;7764.864662217935;7991.4006449515355;8091.352691784761;8169.346452283922;8193.71322003727;30327;30766.692333076382;31314.843425782725;31328.843355783076;31504.212394690316;36565.634343657286;37941.62058379381;38221.80889095537;38533.614663854125;38935.80532097322;9973.60105595768;10060.899391005996;10116.645917392856;10175.185985121025;10537.051665350155;10222.642207522998;10792.974667406585;11024.834627480755;11049.233010968379;11127.94436027847;9735.610575576897;10224.795504089729;10263.12763415118;10263.922288159636;10319.690409287734;9686.031396860539;10148.340357876714;10281.331713438603;10285.2800303978;10312.226583006455;9706.75733106678;10070.546825393021;10115.443650598992;10117.443540605338;10130.949345253226;7907.209279072047;7982.800429989296;7999.200079992187;8315.958420208102;8452.788680282796;7819.178986206594;7976.521408715495;8055.275025247756;8076.596170191349;8540 15:32:50 INFO - PROCESS | 27209 | __end_tp_report 15:32:50 INFO - PROCESS | 27209 | __start_cc_report 15:32:50 INFO - PROCESS | 27209 | _x_x_mozilla_cycle_collect,324 15:32:50 INFO - PROCESS | 27209 | __end_cc_report 15:32:50 INFO - PROCESS | 27209 | __startTimestamp1452382370575__endTimestamp 15:32:50 INFO - PROCESS | 27209 | 15:32:50 INFO - PROCESS | 27209 | ------- Summary: start ------- 15:32:50 INFO - PROCESS | 27209 | Number of tests: 6 15:32:50 INFO - PROCESS | 27209 | 15:32:50 INFO - PROCESS | 27209 | [#0] dojo.html Cycles:165 Average:4599.40 Median:4746.41 stddev:480.73 (10.1%) stddev-sans-first:456.50 15:32:50 INFO - PROCESS | 27209 | Values: 2622.6 2690.6 2722.4 2735.8 2736.2 4474.7 4562.7 4580.0 4605.3 4660.8 4545.2 4576.1 4653.1 4654.5 4688.9 4059.7 4294.1 4296.7 4350.0 4367.2 4146.4 4302.7 4318.8 4358.2 4388.7 4217.3 4226.6 4288.7 4302.5 4316.9 4294.5 4297.8 4298.5 4300.8 4351.4 4073.0 4180.0 4270.9 4280.4 4330.8 4456.6 4480.7 4497.6 4635.4 4685.5 4898.1 4948.2 4983.4 4999.0 5031.9 4865.8 5023.6 5025.5 5035.1 5073.0 4570.1 4617.7 4661.5 4663.3 4719.6 5111.7 5119.8 5140.1 5141.4 5186.5 4746.5 4848.4 4935.1 4960.6 4996.5 4935.3 4980.2 4983.7 5004.4 5049.0 4901.7 4939.0 4950.2 4965.3 4996.6 4733.9 4863.8 4896.9 4929.0 4951.4 4124.6 4129.2 4131.4 4145.6 4165.1 3646.0 3659.8 3664.0 3670.1 3687.5 4148.1 4265.6 4279.1 4308.8 4334.7 4972.6 4988.5 5006.1 5020.7 5053.8 4292.5 4308.8 4317.2 4318.2 4351.2 4267.8 4368.6 4392.3 4418.3 4455.2 4781.3 4808.1 4810.7 4815.3 4832.5 4800.2 5024.4 5026.8 5056.8 5113.5 4669.1 4679.6 4720.2 4738.7 4772.4 4889.2 4905.7 4925.8 4960.3 4981.1 4851.1 4987.4 5013.4 5019.0 5073.8 4797.4 4850.9 4852.8 4858.2 4905.0 4867.6 4877.3 4878.6 4881.0 4909.2 4617.4 4697.2 4746.4 4789.8 4835.2 4879.8 4898.7 4929.0 4934.8 4937.7 4825.1 4838.8 4839.0 4860.0 4886.1 15:32:50 INFO - PROCESS | 27209 | 15:32:50 INFO - PROCESS | 27209 | [#1] ext.html Cycles:180 Average:37638.11 Median:3260.77 stddev:58527.90 (1794.9%) stddev-sans-first:58625.57 15:32:50 INFO - PROCESS | 27209 | Values: 476.0 479.6 488.9 493.3 510.4 25103.7 32988.5 33093.0 33317.8 33394.8 35703.0 36278.5 36305.8 36353.1 36377.1 7599.8 7788.6 7789.5 7796.6 7797.1 7398.9 7535.8 7536.5 7558.8 7566.1 7484.5 7598.8 7600.8 7618.0 7618.8 7415.6 7510.2 7537.1 7542.5 7552.1 7402.5 7560.8 7563.4 7587.1 7766.0 36258.3 36344.1 36677.1 36875.4 36917.6 2865.9 2947.7 2959.9 3014.5 3625.1 27717.6 27892.0 28137.5 28227.4 28345.7 3253.1 3254.2 3267.3 3275.4 3309.0 206826.0 209272.0 209501.0 210122.0 210705.0 45817.1 47298.3 52415.7 53006.2 53429.5 47614.8 47889.0 47945.3 48014.3 48054.0 14086.4 14288.0 14297.4 14303.9 14306.8 11139.5 11187.8 11222.8 11282.9 11291.4 17687.6 18054.9 18117.9 18308.3 18343.5 7424.3 7512.4 7606.4 7613.3 7692.1 772.3 854.4 869.7 873.8 970.4 26052.5 26187.6 26462.3 28435.0 28897.1 914.9 948.3 964.3 996.5 1073.2 12720.4 12997.5 13073.4 13116.6 13147.1 255698.0 259034.0 259093.0 260135.0 260839.0 44019.0 44287.0 44395.6 44466.6 44706.0 1220.8 1228.4 1246.8 1252.6 1253.0 24226.5 25006.6 25197.0 25253.1 25563.4 38746.0 38797.2 38950.2 39021.2 39212.4 201383.0 202824.0 203816.0 204014.0 204270.0 27209.3 27933.3 28609.4 28755.0 28763.0 33556.5 33916.0 34091.7 34162.1 34176.8 30828.0 30882.0 31238.4 31826.5 32184.8 31425.8 31877.7 32066.7 33371.5 33532.5 29906.6 29975.9 29982.7 30225.5 30400.7 26275.3 26789.7 27064.2 27334.6 27542.4 21687.5 21837.3 21862.2 21932.7 22221.0 15:32:50 INFO - PROCESS | 27209 | 15:32:50 INFO - PROCESS | 27209 | [#2] jquery.html Cycles:180 Average:24156.02 Median:272649.64 stddev:79130.33 (29.0%) stddev-sans-first:79332.06 15:32:50 INFO - PROCESS | 27209 | Values: 315.8 317.7 318.6 329.1 336.8 14275.2 14893.2 15002.2 15069.7 15790.0 14270.6 14307.9 15185.2 15189.4 15215.4 4340.2 4716.2 4895.4 4918.1 4923.9 4820.2 4849.1 4882.6 5663.1 5682.9 3433.9 3578.5 4921.5 5632.9 5641.9 5086.6 5087.9 5107.4 5128.4 5142.4 4808.1 5043.0 5065.5 5084.1 5091.9 10882.3 11217.0 11308.9 11345.5 11385.3 1689.2 1702.4 1713.3 1801.3 1861.1 8395.9 8444.5 8528.8 8553.5 8776.1 1711.6 1735.1 1745.7 1779.4 1862.7 42135.4 43635.6 45231.0 49238.8 52658.2 9762.4 9802.5 9806.7 9808.6 9925.0 12347.1 12385.4 12412.9 12414.1 12471.1 6968.2 7037.8 7040.2 7069.7 7122.1 6644.1 6674.1 6680.5 6682.6 6684.7 4089.7 4191.5 4201.3 4201.3 4220.9 1708.7 1746.6 1759.3 1769.5 1793.1 363.9 366.8 392.3 395.3 830.7 8921.1 9009.0 9047.5 9347.0 9701.1 395.1 814.8 882.7 886.7 952.8 8110.6 8215.3 8251.3 8284.7 8404.0 449451.0 467720.0 496060.5 503738.0 503812.0 61480.0 63030.4 63197.1 63330.1 64017.0 1064.6 1078.8 1082.0 1091.8 1092.0 12748.7 12757.4 12956.7 12965.2 13123.8 27157.3 27357.0 27415.0 27598.0 27609.6 37276.6 37573.4 37778.2 38003.8 38416.0 6603.7 6730.2 6739.1 6791.8 7021.3 8954.4 9892.0 10016.6 10401.5 10426.3 7630.4 7742.3 8492.9 8586.9 8677.7 8528.3 8886.2 8975.9 9252.4 9313.8 7832.8 8598.2 8714.5 8716.3 8732.8 6280.3 6519.4 6576.3 6584.0 6587.3 8165.8 8908.8 9110.5 9199.4 9215.7 15:32:50 INFO - PROCESS | 27209 | 15:32:50 INFO - PROCESS | 27209 | [#3] mootools.html Cycles:180 Average:5187.21 Median:6262.30 stddev:2695.36 (43.0%) stddev-sans-first:2687.71 15:32:50 INFO - PROCESS | 27209 | Values: 1378.1 1390.4 1491.0 1701.9 1715.7 6224.8 6364.5 7271.2 7426.1 7468.4 7061.3 7245.2 7273.7 7279.1 7291.6 2116.2 2144.7 2146.4 2146.8 2152.9 2086.3 2122.3 2210.9 2220.3 2224.3 2159.1 2168.0 2179.6 2198.2 2204.9 2176.6 2178.3 2179.3 2183.5 2185.4 2151.9 2167.6 2175.9 2180.6 2189.6 7365.3 7404.1 7432.7 7445.4 7469.3 4371.6 4495.3 4499.8 4506.5 4506.8 2860.7 2898.5 2911.1 2921.1 2971.7 903.2 936.6 947.0 950.2 956.9 10385.5 10453.4 10480.9 10488.1 10492.8 4061.5 4098.5 4139.7 4143.7 4195.8 8785.7 8809.5 8844.6 8846.5 8854.6 4511.5 4518.7 4519.5 4529.4 4531.1 3340.5 3427.0 3815.6 4017.8 4043.3 3566.2 3581.8 3590.0 3622.9 3631.5 1156.6 1188.5 1191.1 1192.8 1196.0 793.8 890.3 1160.5 1162.6 1175.6 6767.3 6770.1 6828.1 6829.5 6835.5 1027.9 1061.7 1062.9 1072.4 1093.0 5411.7 5475.5 5483.8 5500.6 5505.3 8279.3 8768.6 8916.6 8939.6 8941.1 8750.6 8787.7 8828.3 8857.5 8882.4 6929.7 6985.1 6992.6 7188.7 7197.5 6894.4 6911.0 6932.2 6943.9 6978.5 7996.6 8261.5 8288.6 8327.1 8368.2 8208.5 8390.8 8488.4 8522.8 8584.1 6160.7 6263.9 6299.4 6522.2 6533.2 6748.8 6752.6 6756.1 6798.0 6819.2 6387.8 6466.8 6528.9 6584.6 6631.1 6283.3 6486.2 6530.7 6784.4 6790.9 6529.9 6584.0 6587.5 6591.4 6612.0 6167.6 6225.7 6256.8 6257.2 6265.6 6251.8 6260.7 6288.5 6295.9 6305.3 15:32:50 INFO - PROCESS | 27209 | 15:32:50 INFO - PROCESS | 27209 | [#4] prototype.html Cycles:180 Average:4850.59 Median:5528.63 stddev:1439.32 (26.0%) stddev-sans-first:1402.37 15:32:50 INFO - PROCESS | 27209 | Values: 307.1 311.2 312.6 314.8 315.2 5433.9 5561.4 5572.2 5588.8 5613.0 5527.7 5527.9 5529.3 5532.3 5548.9 4124.9 4256.1 4303.4 4304.5 4308.5 4243.5 4255.3 4274.9 4278.8 4281.2 4205.3 4227.4 4228.9 4231.5 4233.2 4228.5 4231.9 4244.3 4246.2 4250.8 3685.8 3706.4 3708.7 3711.5 3713.7 5151.7 5316.3 5328.7 5372.5 5377.4 4890.6 4896.2 4903.3 4904.0 4908.1 5870.1 5870.4 5872.3 5880.0 5881.6 4031.2 4034.6 4038.7 4042.3 4052.8 5884.4 6082.4 6122.1 6126.5 6150.4 4102.7 4133.6 4134.4 4142.2 4150.9 4213.8 4214.1 4214.5 4218.5 4219.5 4819.9 4828.4 4833.6 4841.9 4853.4 5676.8 5787.8 5808.7 5814.6 5816.6 1475.5 1495.4 1503.3 1504.0 1508.3 990.6 995.3 998.2 1012.6 1025.1 5082.0 5090.7 5099.3 5103.3 5115.7 5961.8 6099.3 6099.5 6152.0 6159.9 5088.1 5125.7 5163.0 5182.9 5192.3 3283.0 3314.4 3315.2 3320.1 3326.2 5650.5 5779.5 5781.1 5785.6 5826.7 6277.2 6297.3 6299.9 6308.1 6328.7 5759.1 5791.3 5796.4 5796.7 5816.0 5991.7 6138.5 6151.9 6154.8 6157.7 5907.9 5979.8 5987.5 5994.6 5997.0 5772.6 5774.6 5778.5 5780.6 5798.1 4151.6 4182.6 4190.1 4195.7 4195.8 5887.0 6088.9 6122.3 6126.5 6138.2 5852.6 5882.8 5899.8 5914.9 5917.1 5897.7 5905.9 5908.7 5908.8 5921.6 5695.0 5762.9 5764.3 5774.2 5793.9 5910.7 5927.7 5941.2 5947.5 5957.6 5497.8 5757.5 5774.3 5781.2 5792.5 15:32:50 INFO - PROCESS | 27209 | 15:32:50 INFO - PROCESS | 27209 | [#5] yui.html Cycles:180 Average:11703.12 Median:43613.95 stddev:13033.51 (29.9%) stddev-sans-first:13043.54 15:32:50 INFO - PROCESS | 27209 | Values: 629.9 630.3 699.6 730.5 755.8 11002.4 11111.2 11167.9 11201.6 11213.2 10769.7 10781.1 10809.6 10820.3 10852.3 601.9 613.2 754.8 769.0 771.4 757.9 759.8 765.2 766.9 770.1 805.5 809.5 810.2 811.1 813.1 799.2 801.6 803.6 804.1 805.1 592.6 596.6 597.2 597.4 598.8 11190.2 11199.4 11304.8 11355.4 11373.4 11431.7 11462.3 11697.8 11906.4 12094.2 9155.8 9462.7 9490.4 9494.4 9509.8 3956.3 4050.4 4052.5 4052.5 4142.6 39686.2 39864.6 39959.4 40183.8 40285.8 8602.2 8693.7 8708.7 8733.4 9066.4 15290.3 15362.1 15383.3 15432.3 15469.9 5734.1 5768.8 5806.3 6006.3 6284.3 3466.0 3476.3 3480.9 3495.5 3535.5 2620.9 2653.8 2659.3 2659.7 2659.7 470.9 473.8 474.4 476.7 477.6 509.0 551.8 572.1 574.4 574.6 7273.7 7403.7 7436.6 7451.3 7501.6 621.3 630.8 631.5 635.0 637.6 3639.6 3652.2 3668.2 3682.2 3683.3 43901.3 45123.8 45328.8 45751.3 45817.3 40508.2 40737.2 41021.0 41565.8 43326.6 36864.8 37091.0 38589.8 38735.0 40013.8 7764.9 7991.4 8091.4 8169.3 8193.7 30327.0 30766.7 31314.8 31328.8 31504.2 36565.6 37941.6 38221.8 38533.6 38935.8 9973.6 10060.9 10116.6 10175.2 10537.1 10222.6 10793.0 11024.8 11049.2 11127.9 9735.6 10224.8 10263.1 10263.9 10319.7 9686.0 10148.3 10281.3 10285.3 10312.2 9706.8 10070.5 10115.4 10117.4 10130.9 7907.2 7982.8 7999.2 8316.0 8452.8 7819.2 7976.5 8055.3 8076.6 8540.0 15:32:50 INFO - PROCESS | 27209 | -------- Summary: end -------- 15:32:50 INFO - PROCESS | 27209 | 15:32:51 INFO - TEST-INFO | 27209: exit 0 15:32:51 INFO - TEST-OK | dromaeo_css | took 1113969ms 15:32:51 INFO - TEST-START | kraken 15:32:51 INFO - operating with platform_type : linux_ 15:32:51 INFO - Initialising browser for kraken test... 15:32:51 INFO - TEST-INFO | started process 27452 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW6GvCv/profile http://localhost:57271/getInfo.html) 15:32:54 INFO - PROCESS | 27452 | 15:32:54 INFO - PROCESS | 27452 | (process:27525): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:32:54 INFO - PROCESS | 27452 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:32:55 INFO - PROCESS | 27452 | __metrics Screen width/height:1600/1200 15:32:55 INFO - PROCESS | 27452 | colorDepth:24 15:32:55 INFO - PROCESS | 27452 | Browser inner width/height: 1024/697 15:32:55 INFO - PROCESS | 27452 | __metrics 15:32:55 INFO - PROCESS | 27452 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:32:56 INFO - TEST-INFO | 27452: exit 0 15:32:56 INFO - Browser initialized. 15:32:56 INFO - Running cycle 1/1 for kraken test... 15:32:56 INFO - TEST-INFO | started process 27574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW6GvCv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:57 INFO - PROCESS | 27574 | 15:32:57 INFO - PROCESS | 27574 | (process:27630): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:33:08 INFO - PROCESS | 27574 | RSS: Main: 150327296 15:33:08 INFO - PROCESS | 27574 | 15:33:11 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57271/tests/kraken/driver.html?testName=audio-beat-detection) 15:33:11 INFO - PROCESS | 27574 | RSS: Main: 151330816 15:33:11 INFO - PROCESS | 27574 | 15:33:14 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57271/tests/kraken/driver.html?testName=audio-dft) 15:33:15 INFO - PROCESS | 27574 | RSS: Main: 151863296 15:33:15 INFO - PROCESS | 27574 | 15:33:17 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57271/tests/kraken/driver.html?testName=audio-fft) 15:33:18 INFO - PROCESS | 27574 | RSS: Main: 146096128 15:33:18 INFO - PROCESS | 27574 | 15:33:20 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57271/tests/kraken/driver.html?testName=audio-oscillator) 15:33:21 INFO - PROCESS | 27574 | RSS: Main: 147365888 15:33:21 INFO - PROCESS | 27574 | 15:33:23 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:33:24 INFO - PROCESS | 27574 | RSS: Main: 147144704 15:33:24 INFO - PROCESS | 27574 | 15:33:27 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57271/tests/kraken/driver.html?testName=imaging-darkroom) 15:33:27 INFO - PROCESS | 27574 | RSS: Main: 146083840 15:33:27 INFO - PROCESS | 27574 | 15:33:31 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57271/tests/kraken/driver.html?testName=imaging-desaturate) 15:33:31 INFO - PROCESS | 27574 | RSS: Main: 146399232 15:33:31 INFO - PROCESS | 27574 | 15:33:34 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57271/tests/kraken/driver.html?testName=json-parse-financial) 15:33:35 INFO - PROCESS | 27574 | RSS: Main: 146280448 15:33:35 INFO - PROCESS | 27574 | 15:33:37 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:33:37 INFO - PROCESS | 27574 | RSS: Main: 148819968 15:33:37 INFO - PROCESS | 27574 | 15:33:39 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:33:40 INFO - PROCESS | 27574 | RSS: Main: 149422080 15:33:40 INFO - PROCESS | 27574 | 15:33:42 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:33:42 INFO - PROCESS | 27574 | RSS: Main: 148836352 15:33:42 INFO - PROCESS | 27574 | 15:33:45 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:33:46 INFO - PROCESS | 27574 | RSS: Main: 147533824 15:33:46 INFO - PROCESS | 27574 | 15:33:48 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:33:49 INFO - PROCESS | 27574 | RSS: Main: 148533248 15:33:49 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | Cycle 1(1): loaded http://localhost:57271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57271/tests/kraken/driver.html?testName=ai-astar) 15:33:51 INFO - PROCESS | 27574 | RSS: Main: 149291008 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | __start_tp_report 15:33:51 INFO - PROCESS | 27574 | _x_x_mozilla_page_load 15:33:51 INFO - PROCESS | 27574 | _x_x_mozilla_page_load_details 15:33:51 INFO - PROCESS | 27574 | |i|pagename|runs| 15:33:51 INFO - PROCESS | 27574 | |0;ai-astar;113;110;113;113;112;125;113;113;113;113 15:33:51 INFO - PROCESS | 27574 | |1;audio-beat-detection;153;145;155;174;133;163;152;149;172;134 15:33:51 INFO - PROCESS | 27574 | |2;audio-dft;164;164;164;163;163;166;171;163;166;164 15:33:51 INFO - PROCESS | 27574 | |3;audio-fft;79;75;72;74;137;72;76;74;76;146 15:33:51 INFO - PROCESS | 27574 | |4;audio-oscillator;97;97;141;98;98;97;130;97;98;130 15:33:51 INFO - PROCESS | 27574 | |5;imaging-gaussian-blur;111;111;110;109;110;109;110;110;111;111 15:33:51 INFO - PROCESS | 27574 | |6;imaging-darkroom;149;148;152;148;148;147;149;148;148;148 15:33:51 INFO - PROCESS | 27574 | |7;imaging-desaturate;97;96;96;95;96;96;96;97;97;96 15:33:51 INFO - PROCESS | 27574 | |8;json-parse-financial;71;72;71;73;71;70;72;78;69;71 15:33:51 INFO - PROCESS | 27574 | |9;json-stringify-tinderbox;69;67;68;68;67;68;70;71;68;67 15:33:51 INFO - PROCESS | 27574 | |10;stanford-crypto-aes;82;84;85;86;85;84;85;86;90;84 15:33:51 INFO - PROCESS | 27574 | |11;stanford-crypto-ccm;131;129;128;135;130;135;133;134;129;130 15:33:51 INFO - PROCESS | 27574 | |12;stanford-crypto-pbkdf2;153;153;151;149;152;157;151;148;153;148 15:33:51 INFO - PROCESS | 27574 | |13;stanford-crypto-sha256-iterative;75;76;71;71;74;71;72;71;70;72 15:33:51 INFO - PROCESS | 27574 | __end_tp_report 15:33:51 INFO - PROCESS | 27574 | __start_cc_report 15:33:51 INFO - PROCESS | 27574 | _x_x_mozilla_cycle_collect,837 15:33:51 INFO - PROCESS | 27574 | __end_cc_report 15:33:51 INFO - PROCESS | 27574 | __startTimestamp1452382431489__endTimestamp 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | ------- Summary: start ------- 15:33:51 INFO - PROCESS | 27574 | Number of tests: 14 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#0] ai-astar Cycles:10 Average:113.80 Median:113.00 stddev:4.05 (3.6%) stddev-sans-first:4.28 15:33:51 INFO - PROCESS | 27574 | Values: 113.0 110.0 113.0 113.0 112.0 125.0 113.0 113.0 113.0 113.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#1] audio-beat-detection Cycles:10 Average:153.00 Median:154.00 stddev:13.94 (9.0%) stddev-sans-first:14.78 15:33:51 INFO - PROCESS | 27574 | Values: 153.0 145.0 155.0 174.0 133.0 163.0 152.0 149.0 172.0 134.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:2.44 (1.5%) stddev-sans-first:2.57 15:33:51 INFO - PROCESS | 27574 | Values: 164.0 164.0 164.0 163.0 163.0 166.0 171.0 163.0 166.0 164.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#3] audio-fft Cycles:10 Average:88.10 Median:74.50 stddev:28.30 (38.0%) stddev-sans-first:29.82 15:33:51 INFO - PROCESS | 27574 | Values: 79.0 75.0 72.0 74.0 137.0 72.0 76.0 74.0 76.0 146.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:97.00 stddev:17.76 (18.3%) stddev-sans-first:18.37 15:33:51 INFO - PROCESS | 27574 | Values: 97.0 97.0 141.0 98.0 98.0 97.0 130.0 97.0 98.0 130.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 15:33:51 INFO - PROCESS | 27574 | Values: 111.0 111.0 110.0 109.0 110.0 109.0 110.0 110.0 111.0 111.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.00 stddev:1.35 (0.9%) stddev-sans-first:1.42 15:33:51 INFO - PROCESS | 27574 | Values: 149.0 148.0 152.0 148.0 148.0 147.0 149.0 148.0 148.0 148.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:33:51 INFO - PROCESS | 27574 | Values: 97.0 96.0 96.0 95.0 96.0 96.0 96.0 97.0 97.0 96.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#8] json-parse-financial Cycles:10 Average:71.80 Median:71.50 stddev:2.44 (3.4%) stddev-sans-first:2.57 15:33:51 INFO - PROCESS | 27574 | Values: 71.0 72.0 71.0 73.0 71.0 70.0 72.0 78.0 69.0 71.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 15:33:51 INFO - PROCESS | 27574 | Values: 69.0 67.0 68.0 68.0 67.0 68.0 70.0 71.0 68.0 67.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.00 stddev:2.08 (2.4%) stddev-sans-first:1.88 15:33:51 INFO - PROCESS | 27574 | Values: 82.0 84.0 85.0 86.0 85.0 84.0 85.0 86.0 90.0 84.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:132.00 stddev:2.63 (2.0%) stddev-sans-first:2.79 15:33:51 INFO - PROCESS | 27574 | Values: 131.0 129.0 128.0 135.0 130.0 135.0 133.0 134.0 129.0 130.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:152.50 stddev:2.76 (1.8%) stddev-sans-first:2.87 15:33:51 INFO - PROCESS | 27574 | Values: 153.0 153.0 151.0 149.0 152.0 157.0 151.0 148.0 153.0 148.0 15:33:51 INFO - PROCESS | 27574 | 15:33:51 INFO - PROCESS | 27574 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.00 stddev:2.00 (2.8%) stddev-sans-first:1.87 15:33:51 INFO - PROCESS | 27574 | Values: 75.0 76.0 71.0 71.0 74.0 71.0 72.0 71.0 70.0 72.0 15:33:51 INFO - PROCESS | 27574 | -------- Summary: end -------- 15:33:51 INFO - PROCESS | 27574 | 15:33:52 INFO - TEST-INFO | 27574: exit 0 15:33:52 INFO - TEST-OK | kraken | took 61105ms 15:33:52 INFO - TEST-START | v8_7 15:33:52 INFO - operating with platform_type : linux_ 15:33:52 INFO - Initialising browser for v8_7 test... 15:33:52 INFO - TEST-INFO | started process 27859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp75v8gw/profile http://localhost:57271/getInfo.html) 15:33:55 INFO - PROCESS | 27859 | 15:33:55 INFO - PROCESS | 27859 | (process:27927): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:33:56 INFO - PROCESS | 27859 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 15:33:56 INFO - PROCESS | 27859 | __metrics Screen width/height:1600/1200 15:33:56 INFO - PROCESS | 27859 | colorDepth:24 15:33:56 INFO - PROCESS | 27859 | Browser inner width/height: 1024/697 15:33:56 INFO - PROCESS | 27859 | __metrics 15:33:56 INFO - PROCESS | 27859 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:33:57 INFO - TEST-INFO | 27859: exit 0 15:33:57 INFO - Browser initialized. 15:33:57 INFO - Running cycle 1/1 for v8_7 test... 15:33:57 INFO - TEST-INFO | started process 27976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp75v8gw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:59 INFO - PROCESS | 27976 | 15:33:59 INFO - PROCESS | 27976 | (process:28033): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:34:09 INFO - PROCESS | 27976 | RSS: Main: 150577152 15:34:09 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | Cycle 1(1): loaded http://localhost:57271/tests/v8_7/run.html (next: http://localhost:57271/tests/v8_7/run.html) 15:34:32 INFO - PROCESS | 27976 | RSS: Main: 146038784 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | __start_tp_report 15:34:32 INFO - PROCESS | 27976 | _x_x_mozilla_page_load 15:34:32 INFO - PROCESS | 27976 | _x_x_mozilla_page_load_details 15:34:32 INFO - PROCESS | 27976 | |i|pagename|runs| 15:34:32 INFO - PROCESS | 27976 | |0;Richards;167.16817118020728 15:34:32 INFO - PROCESS | 27976 | |1;DeltaBlue;186.42803877703207 15:34:32 INFO - PROCESS | 27976 | |2;Encrypt;279.4076557697681 15:34:32 INFO - PROCESS | 27976 | |3;Decrypt;5445.652173913043 15:34:32 INFO - PROCESS | 27976 | |4;RayTrace;1071.8113612004288 15:34:32 INFO - PROCESS | 27976 | |5;Earley;723.589001447178 15:34:32 INFO - PROCESS | 27976 | |6;Boyer;12444.444444444445 15:34:32 INFO - PROCESS | 27976 | |7;RegExp;42914.89361702128 15:34:32 INFO - PROCESS | 27976 | |8;Splay;604.5949214026602 15:34:32 INFO - PROCESS | 27976 | |9;NavierStokes;4840.579710144928 15:34:32 INFO - PROCESS | 27976 | __end_tp_report 15:34:32 INFO - PROCESS | 27976 | __startTimestamp1452382472518__endTimestamp 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | ------- Summary: start ------- 15:34:32 INFO - PROCESS | 27976 | Number of tests: 10 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 167.2 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#1] DeltaBlue Cycles:1 Average:186.43 Median:186.43 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 186.4 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 279.4 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#3] Decrypt Cycles:1 Average:5445.65 Median:5445.65 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 5445.7 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#4] RayTrace Cycles:1 Average:1071.81 Median:1071.81 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 1071.8 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#5] Earley Cycles:1 Average:723.59 Median:723.59 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 723.6 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#6] Boyer Cycles:1 Average:12444.44 Median:12444.44 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 12444.4 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#7] RegExp Cycles:1 Average:42914.89 Median:42914.89 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 42914.9 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#8] Splay Cycles:1 Average:604.59 Median:604.59 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 604.6 15:34:32 INFO - PROCESS | 27976 | 15:34:32 INFO - PROCESS | 27976 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 15:34:32 INFO - PROCESS | 27976 | Values: 4840.6 15:34:32 INFO - PROCESS | 27976 | -------- Summary: end -------- 15:34:32 INFO - PROCESS | 27976 | 15:34:33 INFO - TEST-INFO | 27976: exit 0 15:34:33 INFO - TEST-OK | v8_7 | took 41042ms 15:34:33 INFO - SUITE-END | took 1216s 15:34:33 INFO - Completed test suite (00:20:16) 15:34:33 INFO - Working with test: dromaeo_css 15:34:33 INFO - Generating results file: dromaeo_css 15:34:33 INFO - Working with test: kraken 15:34:33 INFO - Generating results file: kraken 15:34:33 INFO - javascript benchmark 15:34:33 INFO - Working with test: v8_7 15:34:33 INFO - Generating results file: v8_7 15:34:33 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:34:33 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 15:34:33 INFO - process_Request line: dromaeo_css 6142.95 graph.html#tests=[[72,132,43]] 15:34:33 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:34:33 INFO - process_Request line: kraken 1563.30 graph.html#tests=[[232,132,43]] 15:34:33 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:34:33 INFO - process_Request line: v8_7 20149.17 graph.html#tests=[[230,132,43]] 15:34:33 INFO - RETURN: dromaeo_css: 6142.95 15:34:33 INFO - RETURN: kraken: 1563.30 15:34:33 INFO - RETURN: v8_7: 20149.17 15:34:33 INFO - javascript benchmark 15:34:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.5934980078086, 2690.59641053842, 2722.3874628208655, 2735.8221715588493, 2736.1654695317934, 4474.709143905644, 4562.680612357136, 4579.977100114499, 4605.286180642006, 4660.813567457302, 4545.204589196894, 4576.130535198318, 4653.115907977482, 4654.464736555297, 4688.906221875561, 4059.7361171523758, 4294.098239369736, 4296.656267498593, 4350.0429905420915, 4367.192069467143, 4146.3780432935155, 4302.65578753699, 4318.8488402905905, 4358.171947330013, 4388.714733542325, 4217.34631132175, 4226.619604235633, 4288.656907447428, 4302.462192225972, 4316.892077698051, 4294.484661840568, 4297.78511074445, 4298.484181898161, 4300.763458009808, 4351.369051487548, 4073.0, 4180.017695841475, 4270.871873843758, 4280.351561136833, 4330.826766929319, 4456.598906098434, 4480.663950203748, 4497.64018878489, 4635.351050852883, 4685.484596694361, 4898.142825005645, 4948.158813001798, 4983.352164218664, 4998.975005124988, 5031.924521132186, 4865.829695960624, 5023.572996295319, 5025.497450254982, 5035.118854200537, 5073.036123136592, 4570.063137056929, 4617.653675974316, 4661.487236403993, 4663.253879379283, 4719.59883409914, 5111.693298402033, 5119.820806271762, 5140.126178549655, 5141.38303403594, 5186.533212010937, 4746.5490778376, 4848.442429120626, 4935.087008903364, 4960.603151747851, 4996.475370086161, 4935.3090567320605, 4980.228064649985, 4983.725895075733, 5004.3994720633755, 5049.0, 4901.730404827768, 4938.975305123451, 4950.18321976877, 4965.329680493087, 4996.550310472075, 4733.881652958704, 4863.781129849165, 4896.926546101811, 4928.975355123202, 4951.405831300267, 4124.649404800625, 4129.215449064728, 4131.400946862688, 4145.585441455831, 4165.10450253191, 3645.9635403646153, 3659.780413175218, 3664.0, 3670.064133645903, 3687.465317528997, 4148.149629325981, 4265.55211702773, 4279.101388708406, 4308.806103725277, 4334.739915605074, 4972.602191824645, 4988.476209997971, 5006.07387633289, 5020.698758074527, 5053.823116190989, 4292.463442069741, 4308.80610372534, 4317.158154159909, 4318.244307246219, 4351.19502891966, 4267.786610669516, 4368.60682538573, 4392.3191905254735, 4418.315161150027, 4455.175792478337, 4781.306710526954, 4808.134535783593, 4810.7113573185725, 4815.277708343637, 4832.49258827818, 4800.207965685623, 5024.447310795883, 5026.824061157842, 5056.7724452399, 5113.463086375877, 4669.066186762593, 4679.578837904605, 4720.150372932768, 4738.715677059387, 4772.379590653193, 4889.217725163957, 4905.730184839868, 4925.778339974638, 4960.255961605788, 4981.053599816023, 4851.078295123915, 4987.376577927759, 5013.423456302572, 5019.0463811875625, 5073.797048118034, 4797.376341075638, 4850.878728031827, 4852.75736213195, 4858.17411040117, 4904.975475122602, 4867.634927380532, 4877.317175595491, 4878.56092951636, 4880.95119048805, 4909.214525675875, 4617.445906491243, 4697.248440249544, 4746.406699162605, 4789.784459699392, 4835.153848076643, 4879.829205977774, 4898.657094003385, 4929.0, 4934.827281045146, 4937.703737775745, 4825.131476334293, 4838.782254798472, 4838.975805120952, 4860.027994401064, 4886.096072226649], "unit": "score", "name": "dojo.html", "value": 4569.815347934175}, {"lowerIsBetter": false, "replicates": [475.969062010969, 479.57317986991586, 488.9315495830584, 493.27734868417804, 510.3544016818724, 25103.74896251039, 32988.515516801745, 33092.99999999997, 33317.83341083297, 33394.833025834836, 35703.0, 36278.45582316267, 36305.81847090761, 36353.0911727207, 36377.090572735695, 7599.848003039922, 7788.649510772028, 7789.454738168331, 7796.649150788228, 7797.103333116679, 7398.926010739904, 7535.849283014364, 7536.510126841765, 7558.848823023536, 7566.054243219598, 7484.476086673935, 7598.8480230395635, 7600.809979750523, 7617.961910190441, 7618.771436856876, 7415.555066696015, 7510.211427800057, 7537.095548534184, 7542.491501699682, 7552.093748750158, 7402.481826272109, 7560.848783024308, 7563.432742544332, 7587.051618547682, 7765.961170194113, 36258.274834503165, 36344.091397715005, 36677.083072923124, 36875.446868297, 36917.63082369169, 2865.899693510717, 2947.7052294770565, 2959.8668059937354, 3014.4724673182322, 3625.148090198801, 27717.58423623647, 27892.0, 28137.452440115787, 28227.435451290858, 28345.716542834514, 3253.1216571525556, 3254.2189874429964, 3267.313864088544, 3275.3613045456145, 3308.983455082709, 206826.0, 209272.0, 209501.0, 210122.0, 210705.0, 45817.08365832665, 47298.29052564214, 52415.73792131091, 53006.204906926425, 53429.465705343224, 47614.76192619015, 47889.0, 47945.28082078772, 48014.27978580324, 48054.0, 14086.43654253839, 14288.0, 14297.356618952172, 14303.856961430462, 14306.785398219035, 11139.498722557504, 11187.776244475064, 11222.775544489064, 11282.887171128348, 11291.435428228555, 17687.557811054827, 18054.90972545129, 18117.909410452863, 18308.267669293346, 18343.54141146482, 7424.294692004251, 7512.436567257478, 7606.353459955855, 7613.276738709814, 7692.076950765944, 772.25863171355, 854.4446110028407, 869.6956065377068, 873.8208667223204, 970.4322971062007, 26052.478950420886, 26187.607185892226, 26462.33844153873, 28435.0, 28897.133086007034, 914.8518609145613, 948.2698322291797, 964.3490643815396, 996.4519514267124, 1073.2058276875057, 12720.363981801058, 12997.545085921947, 13073.411696473682, 13116.606501804961, 13147.14543554666, 255698.0, 259034.0, 259093.0, 260135.0, 260839.0, 44019.0, 44287.0, 44395.556044439785, 44466.555334446886, 44706.0, 1220.7619514194823, 1228.444834743731, 1246.8005119180887, 1252.5803855708439, 1253.022642338977, 24226.51546969086, 25006.62490062687, 25197.0, 25253.11614093498, 25563.36091597725, 38746.0, 38797.2240555193, 38950.220995579366, 39021.2195756089, 39212.41181382338, 201383.0, 202824.0, 203816.0, 204014.0, 204270.0, 27209.319767005192, 27933.301667458476, 28609.42781144407, 28755.0, 28763.0, 33556.496652549744, 33916.0, 34091.65908340885, 34162.14594635154, 34176.82911585525, 30828.0, 30882.0, 31238.375232495677, 31826.522602160523, 32184.83907580447, 31425.8428707855, 31877.681223187472, 32066.679333206368, 33371.49942750812, 33532.49701254434, 29906.551401729426, 29975.850120749255, 29982.700172998862, 30225.546616801206, 30400.695993039786, 26275.343116422242, 26789.732102678725, 27064.1880743578, 27334.5899811499, 27542.449151016466, 21687.45781355479, 21837.344879653636, 21862.23482178116, 21932.671009934544, 22221.0], "unit": "score", "name": "ext.html", "value": 16034.184284480909}, {"lowerIsBetter": false, "replicates": [315.81840441746004, 317.69659974724135, 318.60970311368567, 329.0736576537048, 336.7524869221122, 14275.214863182533, 14893.180875051868, 15002.249887505608, 15069.698606027887, 15790.0, 14270.643233919158, 14307.928460357683, 15185.240737963113, 15189.392424303041, 15215.39138434464, 4340.218760623079, 4716.174669432836, 4895.437024742165, 4918.0901533216465, 4923.876903077416, 4820.204666230068, 4849.102915960541, 4882.584980276681, 5663.0655941769555, 5682.914756278638, 3433.896983090511, 3578.516900218476, 4921.507849215086, 5632.915506267409, 5641.8589535261535, 5086.618503612225, 5087.931534377785, 5107.387113546398, 5128.435872054071, 5142.3829140503, 4808.110499557593, 5042.974785126087, 5065.544101030925, 5084.059449001909, 5091.8981620367385, 10882.347059176474, 11217.04655104309, 11308.886911130865, 11345.546178152865, 11385.259958102697, 1689.1891891891837, 1702.446704820938, 1713.323237321251, 1801.2704854533936, 1861.1252711225702, 8395.916040839575, 8444.493330400195, 8528.829423411558, 8553.48679079251, 8776.122387761237, 1711.5977745229861, 1735.1150913034444, 1745.7206846904562, 1779.421687951408, 1862.748528948588, 42135.36796948048, 43635.563644363465, 45231.0, 49238.75380623074, 52658.21012684813, 9762.426335198024, 9802.509874506246, 9806.65676701312, 9808.558614862348, 9925.0, 12347.13570050088, 12385.442655080544, 12412.937935310265, 12414.131010829155, 12471.127021108618, 6968.198657154391, 7037.753678621224, 7040.225575186725, 7069.71721131149, 7122.109736282965, 6644.069830223772, 6674.06563081169, 6680.532362734659, 6682.599044057372, 6684.699188536528, 4089.7137200395687, 4191.455110835572, 4201.306784380604, 4201.306784380604, 4220.915581688349, 1708.709519381708, 1746.6244757377224, 1759.2962814873897, 1769.4517297364805, 1793.0765655687333, 363.88355726167373, 366.8349242840732, 392.2625464127422, 395.2904536357246, 830.7424698343533, 8921.063288354759, 9008.954955225181, 9047.457152570867, 9346.953265233631, 9701.126898579161, 395.1129713792554, 814.8207394373228, 882.668999125328, 886.7206829848577, 952.8427809411509, 8110.594470276463, 8215.260626543639, 8251.257386835214, 8284.668613255522, 8404.033536143423, 449451.0, 467720.0, 496060.5196973992, 503738.0, 503812.0, 61480.0, 63030.36969630245, 63197.052044219374, 63330.0500492493, 64017.0, 1064.6486659402378, 1078.8166011778017, 1082.0423924826584, 1091.792559413709, 1091.9617813376335, 12748.745025099632, 12757.362131893553, 12956.740865182455, 12965.22208667483, 13123.803142953055, 27157.321066973484, 27357.0, 27415.0, 27598.0, 27609.585856212576, 37276.62723372732, 37573.43639845459, 37778.244435110595, 38003.80998094992, 38416.0, 6603.702833372606, 6730.226024007106, 6739.05653208561, 6791.830204244933, 7021.297870212938, 8954.417962832395, 9891.950540247253, 10016.64941727036, 10401.479926003518, 10426.322289051188, 7630.389568834591, 7742.341900938483, 8492.872606911025, 8586.871196932176, 8677.696280630147, 8528.317734581095, 8886.24466920319, 8975.865362019706, 9252.352335336462, 9313.813723725623, 7832.765017049498, 8598.183172598594, 8714.477131372138, 8716.302695784196, 8732.825343493221, 6280.340564240689, 6519.380658837403, 6576.309487503743, 6584.04531342943, 6587.2753997061245, 8165.79585510367, 8908.777280568038, 9110.544472776468, 9199.35604507678, 9215.723528294162], "unit": "score", "name": "jquery.html", "value": 7069.63532766722}, {"lowerIsBetter": false, "replicates": [1378.124890694409, 1390.3951780975276, 1490.9925450372746, 1701.9489415317544, 1715.6568686262742, 6224.84437889053, 6364.490840732742, 7271.236520165379, 7426.145993210783, 7468.365188958938, 7061.293870612949, 7245.166805817333, 7273.745418910339, 7279.126504819429, 7291.635418229094, 2116.1958455786817, 2144.742630884296, 2146.431195733132, 2146.8175205107586, 2152.9031193596325, 2086.3428020173674, 2122.3420739570784, 2210.944726381845, 2220.2562141682474, 2224.343818573525, 2159.0500179920864, 2168.024389024937, 2179.5967745967046, 2198.2196320306302, 2204.867707937529, 2176.6082105221053, 2178.302943058222, 2179.259051922346, 2183.4868805830615, 2185.4317877352005, 2151.9462013449634, 2167.631502644554, 2175.9238426654993, 2180.5856887191385, 2189.562087582474, 7365.337119659256, 7404.074490688664, 7432.665530051161, 7445.367143792784, 7469.253074692541, 4371.562843715635, 4495.325701144821, 4499.775011249424, 4506.5493450655, 4506.819727210907, 2860.699626539225, 2898.507253766865, 2911.141213342069, 2921.0506585359844, 2971.7028297170327, 903.1826197291396, 936.6440752514001, 946.9621215151386, 950.1733491862055, 956.8803899512561, 10385.532651030646, 10453.37279763209, 10480.94759526205, 10488.108510776594, 10492.842607360895, 4061.5329237138108, 4098.4876890388705, 4139.710220284612, 4143.70994030421, 4195.832166713297, 8785.69250076257, 8809.515476648847, 8844.55777211137, 8846.513441760637, 8854.557272136368, 4511.526289739596, 4518.661100417482, 4519.480259770103, 4529.365888775574, 4531.116432295737, 3340.5323254744353, 3426.9828650856584, 3815.5802861685747, 4017.83928642851, 4043.272211001989, 3566.1797786509246, 3581.83881725323, 3590.030691713223, 3622.8550857965915, 3631.5460567429072, 1156.6414411532285, 1188.4948896719034, 1191.065013964034, 1192.7733730591333, 1196.0, 793.7698067560343, 890.2966656341547, 1160.512584714422, 1162.610525473959, 1175.647305808254, 6767.323267673291, 6770.052192693027, 6828.146481689789, 6829.453643708591, 6835.521513494008, 1027.8817935937313, 1061.7292590389402, 1062.8724553053528, 1072.4423299884018, 1093.0435868614961, 5411.729413529308, 5475.479829416199, 5483.7806487740045, 5500.559955203574, 5505.311836020497, 8279.337652987746, 8768.605412756442, 8916.643334266557, 8939.597718102701, 8941.077668301215, 8750.606222719865, 8787.692430764893, 8828.337874659297, 8857.512836793909, 8882.378233523592, 6929.688164032631, 6985.091938048021, 6992.580445173306, 7188.676509556978, 7197.496175267681, 6894.413974812197, 6911.0, 6932.237453879969, 6943.861122777617, 6978.511504194657, 7996.640151193326, 8261.463004904663, 8288.58557072132, 8327.125651806473, 8368.24685778283, 8208.507489550646, 8390.790230244293, 8488.363372746946, 8522.829543409222, 8584.098669639598, 6160.722767475385, 6263.937360626518, 6299.433051025247, 6522.21733391996, 6533.18335208099, 6748.797536073926, 6752.5948443093575, 6756.054152418567, 6797.966010169917, 6819.181698196248, 6387.776427825004, 6466.838329041811, 6528.9020664689115, 6584.572002819801, 6631.104800851823, 6283.3402492737605, 6486.156799616208, 6530.706118224596, 6784.423324017514, 6790.932090679227, 6529.922562777088, 6583.967080164569, 6587.473002159912, 6591.406773390418, 6611.966940165268, 6167.629942203482, 6225.688715564294, 6256.812295631138, 6257.217847769029, 6265.592736472115, 6251.812445626639, 6260.655663938527, 6288.496920246278, 6295.874082518416, 6305.274893387135], "unit": "score", "name": "mootools.html", "value": 4265.458327350559}, {"lowerIsBetter": false, "replicates": [307.0726406253116, 311.1971114524527, 312.6404634670129, 314.7576366198026, 315.2449882531337, 5433.918491222635, 5561.416051314614, 5572.247746554214, 5588.832335029945, 5613.045782217023, 5527.695976721288, 5527.944720552793, 5529.30883639545, 5532.2531458253125, 5548.91676624851, 4124.855630052949, 4256.063665993476, 4303.35449682547, 4304.526502084768, 4308.547602501739, 4243.511996120455, 4255.255330317197, 4274.935875961863, 4278.828846846122, 4281.165172791307, 4205.2851015327315, 4227.387028880826, 4228.915421691564, 4231.534531201565, 4233.216854881842, 4228.534861165269, 4231.851885184004, 4244.299690551055, 4246.193223287596, 4250.787460626987, 3685.7788532688123, 3706.42550404685, 3708.6662200402093, 3711.4989476420606, 3713.740038197327, 5151.742412879341, 5316.308879845634, 5328.706921119337, 5372.462753724635, 5377.435369286208, 4890.633202509791, 4896.192128298826, 4903.313536104948, 4904.0437114762635, 4908.141075311806, 5870.11948207768, 5870.354261031283, 5872.265966754156, 5880.0, 5881.647101173943, 4031.23406552757, 4034.616711412411, 4038.6567141792984, 4042.272390969624, 4052.8176232069627, 5884.411558844125, 6082.422169893853, 6122.14289999396, 6126.479249263818, 6150.384961503859, 4102.651274641689, 4133.627973482341, 4134.421181034658, 4142.171565686875, 4150.8547200848425, 4213.768242746617, 4214.1150358425075, 4214.473190851144, 4218.472690913636, 4219.472565929259, 4819.855404337875, 4828.37231159954, 4833.613310935187, 4841.8547443576745, 4853.39332583427, 5676.772929082873, 5787.768489260467, 5808.709564521757, 5814.622049566765, 5816.5928385013485, 1475.4983305676121, 1495.364470100203, 1503.3084781000643, 1504.0374160537265, 1508.3287936868207, 990.64336838738, 995.3132338686283, 998.236349192868, 1012.6253286283975, 1025.092792878308, 5082.009008243357, 5090.745462726849, 5099.260607211933, 5103.336566246438, 5115.71863547501, 5961.791337303173, 6099.329073801879, 6099.542534309856, 6152.0, 6159.876802463926, 5088.1350170471105, 5125.666831655931, 5163.044836705221, 5182.896342073137, 5192.273081768555, 3282.983585082107, 3314.353701028276, 3315.1712071982006, 3320.1035720355367, 3326.151831283007, 5650.491455769001, 5779.508741756914, 5781.075027995501, 5785.623934444247, 5826.6795326256615, 6277.24673039229, 6297.27581328144, 6299.905501417483, 6308.116863639094, 6328.651924144124, 5759.107338362561, 5791.276090488689, 5796.449337312949, 5796.739146738491, 5815.982203114438, 5991.670458124845, 6138.508919286357, 6151.9384806151365, 6154.753809847556, 6157.661328626789, 5907.940920590739, 5979.833932383143, 5987.520998320037, 5994.550408719277, 5997.0, 5772.6247793894945, 5774.595778295479, 5778.451047150514, 5780.5953583248765, 5798.10129429939, 4151.584841515824, 4182.581741825915, 4190.099128687347, 4195.748255104703, 4195.790210489402, 5886.970565147147, 6088.908666370096, 6122.326544080059, 6126.509879209563, 6138.232720909887, 5852.648841069549, 5882.823515294548, 5899.793507227227, 5914.881702365842, 5917.053271476543, 5897.67562784051, 5905.852353691193, 5908.734106965283, 5908.763649453974, 5921.585489015728, 5695.0, 5762.94237057624, 5764.250647415809, 5774.191613174243, 5793.9420605795085, 5910.70446477683, 5927.733252003584, 5941.197938278277, 5947.464728174485, 5957.6127551709, 5497.8075767347955, 5757.539396848326, 5774.307083150049, 5781.219535362672, 5792.507636850914], "unit": "score", "name": "prototype.html", "value": 4385.863116051236}, {"lowerIsBetter": false, "replicates": [629.8897692903743, 630.3444417805482, 699.5724834823162, 730.5032577847063, 755.8488302339533, 11002.449877506133, 11111.166662500304, 11167.944160279187, 11201.60794372197, 11213.215074944757, 10769.730756731085, 10781.137508999282, 10809.621663241787, 10820.296680715768, 10852.294600850939, 601.8555546668812, 613.1630324606924, 754.7735679296217, 768.9692412303501, 771.4329967473931, 757.8787394016958, 759.8062494064034, 765.2347652347653, 766.8888011238395, 770.0797546931419, 805.5287656720825, 809.4900212865915, 810.2181394953868, 811.0713233347814, 813.1015228172843, 799.2007992007963, 801.6472751989136, 803.6263137641025, 804.1355542791523, 805.0781854776307, 592.5970340168684, 596.6122020686545, 597.235538510707, 597.3518732175595, 598.8083813179784, 11190.216684832065, 11199.440027998568, 11304.773904521864, 11355.375454350007, 11373.374464404455, 11431.714207144805, 11462.312261264267, 11697.824532632018, 11906.404679765978, 12094.153409261355, 9155.816883662355, 9462.668806591737, 9490.383125096847, 9494.430334179902, 9509.762255943588, 3956.287868183726, 4050.3721923101966, 4052.4731784867777, 4052.5136983561865, 4142.647874930634, 39686.20627587461, 39864.60473883429, 39959.40060899089, 40183.79908100441, 40285.79857100725, 8602.18279263469, 8693.739187824376, 8708.651653933772, 8733.432326898732, 9066.365354425126, 15290.311935962909, 15362.078275303518, 15383.307751151002, 15432.305546250445, 15469.922650386676, 5734.139879018097, 5768.826935191951, 5806.332271788799, 6006.339302676702, 6284.3087260402235, 3466.0, 3476.2526056897887, 3480.89557313281, 3495.528103705967, 3535.4520049392386, 2620.868956552165, 2653.787696984237, 2659.348459627404, 2659.7074321824584, 2659.734026597325, 470.89404883901534, 473.8246848665947, 474.35014030777364, 476.6734786671141, 477.59165913144454, 509.0, 551.8454832646865, 572.090376301674, 574.371063685264, 574.5518495573459, 7273.6726847292, 7403.666834992438, 7436.628168591657, 7451.254874512505, 7501.624918754041, 621.2824188062795, 630.8424041883196, 631.4916492223712, 634.9935352466392, 637.5664548107331, 3639.5632524097277, 3652.196516766307, 3668.192997540537, 3682.1715114099115, 3683.2817600567632, 43901.341479877825, 45123.774381127885, 45328.77335613301, 45751.313730293405, 45817.312740308924, 40508.18983620311, 40737.18525629471, 41021.0, 41565.79217103895, 43326.56673433288, 36864.815675921986, 37091.0, 38589.80705096456, 38735.031624209056, 40013.79993100074, 7764.864662217935, 7991.4006449515355, 8091.352691784761, 8169.346452283922, 8193.71322003727, 30327.0, 30766.692333076382, 31314.843425782725, 31328.843355783076, 31504.212394690316, 36565.634343657286, 37941.62058379381, 38221.80889095537, 38533.614663854125, 38935.80532097322, 9973.60105595768, 10060.899391005996, 10116.645917392856, 10175.185985121025, 10537.051665350155, 10222.642207522998, 10792.974667406585, 11024.834627480755, 11049.233010968379, 11127.94436027847, 9735.610575576897, 10224.795504089729, 10263.12763415118, 10263.922288159636, 10319.690409287734, 9686.031396860539, 10148.340357876714, 10281.331713438603, 10285.2800303978, 10312.226583006455, 9706.75733106678, 10070.546825393021, 10115.443650598992, 10117.443540605338, 10130.949345253226, 7907.209279072047, 7982.800429989296, 7999.200079992187, 8315.958420208102, 8452.788680282796, 7819.178986206594, 7976.521408715495, 8055.275025247756, 8076.596170191349, 8540.0], "unit": "score", "name": "yui.html", "value": 5544.460774980523}], "name": "dromaeo_css", "value": 6142.948264548801}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 113.0, 113.0, 112.0, 125.0, 113.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [153.0, 145.0, 155.0, 174.0, 133.0, 163.0, 152.0, 149.0, 172.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 153.0}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 163.0, 163.0, 166.0, 171.0, 163.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [79.0, 75.0, 72.0, 74.0, 137.0, 72.0, 76.0, 74.0, 76.0, 146.0], "unit": "score", "name": "audio-fft", "value": 88.1}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 141.0, 98.0, 98.0, 97.0, 130.0, 97.0, 98.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 152.0, 148.0, 148.0, 147.0, 149.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 73.0, 71.0, 70.0, 72.0, 78.0, 69.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 68.0, 68.0, 67.0, 68.0, 70.0, 71.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 85.0, 86.0, 85.0, 84.0, 85.0, 86.0, 90.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.1}, {"lowerIsBetter": true, "replicates": [131.0, 129.0, 128.0, 135.0, 130.0, 135.0, 133.0, 134.0, 129.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.4}, {"lowerIsBetter": true, "replicates": [153.0, 153.0, 151.0, 149.0, 152.0, 157.0, 151.0, 148.0, 153.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.5}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 71.0, 71.0, 74.0, 71.0, 72.0, 71.0, 70.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1563.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [186.42803877703207], "unit": "score", "name": "DeltaBlue", "value": 354.6569519999998}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5445.652173913043], "unit": "score", "name": "Decrypt", "value": 48.87954491017965}, {"lowerIsBetter": false, "replicates": [1071.8113612004288], "unit": "score", "name": "RayTrace", "value": 690.4097369999998}, {"lowerIsBetter": false, "replicates": [723.589001447178], "unit": "score", "name": "Earley", "value": 921.051866}, {"lowerIsBetter": false, "replicates": [12444.444444444445], "unit": "score", "name": "Boyer", "value": 53.555062500000005}, {"lowerIsBetter": false, "replicates": [42914.89361702128], "unit": "score", "name": "RegExp", "value": 21.227711948438284}, {"lowerIsBetter": false, "replicates": [604.5949214026602], "unit": "score", "name": "Splay", "value": 134.78611399999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20149.170743710707}]} 15:34:33 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20149.17"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1563.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6142.95"}}} 15:34:33 INFO - Return code: 0 15:34:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:34:33 INFO - # TBPL SUCCESS # 15:34:33 INFO - Running post-action listener: _resource_record_post_action 15:34:33 INFO - Running post-run listener: _resource_record_post_run 15:34:34 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 561029120; Read time: 0; Write time: 500796 15:34:34 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 240865280; Read time: 0; Write time: 242900 15:34:34 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 320163840; Read time: 0; Write time: 257896 15:34:34 INFO - Running post-run listener: _upload_blobber_files 15:34:34 INFO - Blob upload gear active. 15:34:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:34:34 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 15:34:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:34:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:34:35 INFO - (blobuploader) - INFO - Open directory for files ... 15:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:36 INFO - (blobuploader) - INFO - Done attempting. 15:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:37 INFO - (blobuploader) - INFO - Done attempting. 15:34:37 INFO - (blobuploader) - INFO - Iteration through files over. 15:34:37 INFO - Return code: 0 15:34:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:34:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:34:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbf147c0ae2dfa4006dd1cc8ddbb3b2283db8263671c9be10636fcdc13d57123ebf18f5539130be3e92c4f20d8b656c38e67c8194a03bd41c9deea9dcc3df4ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff39e8e704da203db26e01221c32bbe0a96cccc86968f5781512f9d47337909e5d7b13f0523071488ade69a6da3f3bccada8d2994d95918a8d155d52a6a1324c"} 15:34:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:34:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:34:37 INFO - Contents: 15:34:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbf147c0ae2dfa4006dd1cc8ddbb3b2283db8263671c9be10636fcdc13d57123ebf18f5539130be3e92c4f20d8b656c38e67c8194a03bd41c9deea9dcc3df4ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff39e8e704da203db26e01221c32bbe0a96cccc86968f5781512f9d47337909e5d7b13f0523071488ade69a6da3f3bccada8d2994d95918a8d155d52a6a1324c"} 15:34:37 INFO - Copying logs to upload dir... 15:34:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.139050 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-09 15:34:36.598655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 15:34:36.602272) ========= 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=1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbf147c0ae2dfa4006dd1cc8ddbb3b2283db8263671c9be10636fcdc13d57123ebf18f5539130be3e92c4f20d8b656c38e67c8194a03bd41c9deea9dcc3df4ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff39e8e704da203db26e01221c32bbe0a96cccc86968f5781512f9d47337909e5d7b13f0523071488ade69a6da3f3bccada8d2994d95918a8d155d52a6a1324c"} build_url:https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/DXjsw6S0Re24Y0Kdb5ivBA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbf147c0ae2dfa4006dd1cc8ddbb3b2283db8263671c9be10636fcdc13d57123ebf18f5539130be3e92c4f20d8b656c38e67c8194a03bd41c9deea9dcc3df4ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff39e8e704da203db26e01221c32bbe0a96cccc86968f5781512f9d47337909e5d7b13f0523071488ade69a6da3f3bccada8d2994d95918a8d155d52a6a1324c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 15:34:36.628261) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:34:36.628682) ========= 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=1f5564757af27664ca02d71f000001b0-1452375157.187927-882520555 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 15:34:36.713259) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 15:34:36.713632) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 15:34:36.714532) ========= ========= Total master_lag: 2.00 =========